builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0044 starttime: 1448076788.0 results: success (0) buildid: 20151120175133 builduid: c2e7929c885145ffa530790a18e99de9 revision: 3929c7bc30e88d9c12c6cda017dde930eb7ff3c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.003542) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.004172) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.004530) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005618 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.026736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.027083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.042109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.042553) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005603 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.094017) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.094721) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.095638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.095974) ========= 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.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 --2015-11-20 19:33:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.70M=0.001s 2015-11-20 19:33:08 (8.70 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.300177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.300567) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.025439 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:08.349649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 19:33:08.350046) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3929c7bc30e88d9c12c6cda017dde930eb7ff3c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3929c7bc30e88d9c12c6cda017dde930eb7ff3c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 2015-11-20 19:33:08,426 truncating revision to first 12 chars 2015-11-20 19:33:08,426 Setting DEBUG logging. 2015-11-20 19:33:08,427 attempt 1/10 2015-11-20 19:33:08,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3929c7bc30e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 19:33:09,644 unpacking tar archive at: fx-team-3929c7bc30e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 19:33:09.824569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:09.824938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:09.836958) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:09.837561) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:33:09.838261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-20 19:33:09.838800) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:33:10 INFO - MultiFileLogger online at 20151120 19:33:10 in /builds/slave/test 19:33:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:33:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:33:10 INFO - {'append_to_log': False, 19:33:10 INFO - 'base_work_dir': '/builds/slave/test', 19:33:10 INFO - 'blob_upload_branch': 'Fx-Team', 19:33:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:33:10 INFO - 'branch': 'Fx-Team', 19:33:10 INFO - 'buildbot_json_path': 'buildprops.json', 19:33:10 INFO - 'config_files': ('talos/mac_config.py',), 19:33:10 INFO - 'default_actions': ('clobber', 19:33:10 INFO - 'read-buildbot-config', 19:33:10 INFO - 'download-and-extract', 19:33:10 INFO - 'populate-webroot', 19:33:10 INFO - 'create-virtualenv', 19:33:10 INFO - 'install', 19:33:10 INFO - 'run-tests'), 19:33:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:33:10 INFO - 'download_minidump_stackwalk': True, 19:33:10 INFO - 'download_symbols': 'ondemand', 19:33:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:33:10 INFO - 'tooltool.py': '/tools/tooltool.py', 19:33:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:33:10 INFO - '/tools/misc-python/virtualenv.py')}, 19:33:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:33:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:33:10 INFO - 'installer_path': 'installer.exe', 19:33:10 INFO - 'log_level': 'info', 19:33:10 INFO - 'log_name': 'talos', 19:33:10 INFO - 'log_to_console': True, 19:33:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:33:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:33:10 INFO - 'opt_config_files': (), 19:33:10 INFO - 'pip_index': False, 19:33:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:33:10 INFO - 'cmd': ('bash', 19:33:10 INFO - '-c', 19:33:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:33:10 INFO - 'enabled': True, 19:33:10 INFO - 'halt_on_failure': False, 19:33:10 INFO - 'name': 'check_screen_resolution'},), 19:33:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:33:10 INFO - 'cmd': ('bash', 19:33:10 INFO - '-c', 19:33:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:33:10 INFO - 'enabled': True, 19:33:10 INFO - 'halt_on_failure': False, 19:33:10 INFO - 'name': 'check_screen_resolution'},), 19:33:10 INFO - 'run_cmd_checks_enabled': True, 19:33:10 INFO - 'sps_profile': False, 19:33:10 INFO - 'sps_profile_interval': 0, 19:33:10 INFO - 'suite': 'dromaeojs', 19:33:10 INFO - 'system_bits': '64', 19:33:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:33:10 INFO - 'title': 't-yosemite-r7-0044', 19:33:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:33:10 INFO - 'use_talos_json': True, 19:33:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:33:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:33:10 INFO - 'work_dir': 'build'} 19:33:10 INFO - ##### 19:33:10 INFO - ##### Running clobber step. 19:33:10 INFO - ##### 19:33:10 INFO - Running pre-action listener: _resource_record_pre_action 19:33:10 INFO - Running main action method: clobber 19:33:10 INFO - rmtree: /builds/slave/test/build 19:33:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:33:12 INFO - Running post-action listener: _resource_record_post_action 19:33:12 INFO - ##### 19:33:12 INFO - ##### Running read-buildbot-config step. 19:33:12 INFO - ##### 19:33:12 INFO - Running pre-action listener: _resource_record_pre_action 19:33:12 INFO - Running main action method: read_buildbot_config 19:33:12 INFO - Using buildbot properties: 19:33:12 INFO - { 19:33:12 INFO - "properties": { 19:33:12 INFO - "buildnumber": 14, 19:33:12 INFO - "product": "firefox", 19:33:12 INFO - "script_repo_revision": "production", 19:33:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:33:12 INFO - "repository": "", 19:33:12 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:33:12 INFO - "buildid": "20151120175133", 19:33:12 INFO - "slavename": "t-yosemite-r7-0044", 19:33:12 INFO - "pgo_build": "False", 19:33:12 INFO - "basedir": "/builds/slave/test", 19:33:12 INFO - "project": "", 19:33:12 INFO - "platform": "yosemite_r7", 19:33:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:33:12 INFO - "slavebuilddir": "test", 19:33:12 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:33:12 INFO - "branch": "fx-team", 19:33:12 INFO - "repo_path": "integration/fx-team", 19:33:12 INFO - "stage_platform": "macosx64", 19:33:12 INFO - "builduid": "c2e7929c885145ffa530790a18e99de9", 19:33:12 INFO - "revision": "3929c7bc30e88d9c12c6cda017dde930eb7ff3c5" 19:33:12 INFO - }, 19:33:12 INFO - "sourcestamp": { 19:33:12 INFO - "repository": "", 19:33:12 INFO - "hasPatch": false, 19:33:12 INFO - "project": "", 19:33:12 INFO - "branch": "fx-team-macosx64-talos", 19:33:12 INFO - "changes": [ 19:33:12 INFO - { 19:33:12 INFO - "category": null, 19:33:12 INFO - "files": [ 19:33:12 INFO - { 19:33:12 INFO - "url": null, 19:33:12 INFO - "name": "https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:33:12 INFO - } 19:33:12 INFO - ], 19:33:12 INFO - "repository": "", 19:33:12 INFO - "rev": "3929c7bc30e88d9c12c6cda017dde930eb7ff3c5", 19:33:12 INFO - "who": "jsantell@mozilla.com", 19:33:12 INFO - "when": 1448076243, 19:33:12 INFO - "number": 6691798, 19:33:12 INFO - "comments": "Bug 1226319 - pt1 - Move react tree widget in memory tool to shared components. r=fitzgen\n", 19:33:12 INFO - "project": "", 19:33:12 INFO - "at": "Fri 20 Nov 2015 19:24:03", 19:33:12 INFO - "branch": "fx-team-macosx64-talos", 19:33:12 INFO - "revlink": "", 19:33:12 INFO - "properties": [ 19:33:12 INFO - [ 19:33:12 INFO - "buildid", 19:33:12 INFO - "20151120175133", 19:33:12 INFO - "Change" 19:33:12 INFO - ], 19:33:12 INFO - [ 19:33:12 INFO - "builduid", 19:33:12 INFO - "c2e7929c885145ffa530790a18e99de9", 19:33:12 INFO - "Change" 19:33:12 INFO - ], 19:33:12 INFO - [ 19:33:12 INFO - "pgo_build", 19:33:12 INFO - "False", 19:33:12 INFO - "Change" 19:33:12 INFO - ] 19:33:12 INFO - ], 19:33:12 INFO - "revision": "3929c7bc30e88d9c12c6cda017dde930eb7ff3c5" 19:33:12 INFO - } 19:33:12 INFO - ], 19:33:12 INFO - "revision": "3929c7bc30e88d9c12c6cda017dde930eb7ff3c5" 19:33:12 INFO - } 19:33:12 INFO - } 19:33:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:33:12 INFO - Running post-action listener: _resource_record_post_action 19:33:12 INFO - ##### 19:33:12 INFO - ##### Running download-and-extract step. 19:33:12 INFO - ##### 19:33:12 INFO - Running pre-action listener: _resource_record_pre_action 19:33:12 INFO - Running main action method: download_and_extract 19:33:12 INFO - mkdir: /builds/slave/test/build/tests 19:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:12 INFO - https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:33:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/test_packages.json 19:33:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/test_packages.json 19:33:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:33:13 INFO - Downloaded 1149 bytes. 19:33:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:33:13 INFO - Using the following test package requirements: 19:33:13 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:33:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:33:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'jsshell-mac.zip'], 19:33:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:33:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:33:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:33:13 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:33:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:33:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:33:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:33:13 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:33:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:33:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:13 INFO - https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:33:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:33:14 INFO - Downloaded 17525279 bytes. 19:33:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:33:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:33:17 INFO - Return code: 0 19:33:17 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:17 INFO - https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:33:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:33:18 INFO - Downloaded 17525279 bytes. 19:33:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:33:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:33:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:33:21 INFO - Return code: 0 19:33:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:21 INFO - https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:33:22 INFO - Downloaded 11130997 bytes. 19:33:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 19:33:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:33:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:33:23 INFO - Return code: 0 19:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:23 INFO - https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 19:33:26 INFO - Downloaded 109635432 bytes. 19:33:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:33:26 INFO - mkdir: /builds/slave/test/properties 19:33:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:33:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:33:26 INFO - Contents: 19:33:26 INFO - build_url:https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:33:26 INFO - Running post-action listener: _resource_record_post_action 19:33:26 INFO - Running post-action listener: set_extra_try_arguments 19:33:26 INFO - ##### 19:33:26 INFO - ##### Running populate-webroot step. 19:33:26 INFO - ##### 19:33:26 INFO - Running pre-action listener: _resource_record_pre_action 19:33:26 INFO - Running main action method: populate_webroot 19:33:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:33:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:33:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:33:26 INFO - '../fennec_ids.txt'], 19:33:26 INFO - 'tests': ['tcheck2']}, 19:33:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:33:26 INFO - '--tppagecycles', 19:33:26 INFO - '7'], 19:33:26 INFO - 'tests': ['tsvgm']}}, 19:33:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:33:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:33:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:33:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:33:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'tests': ['damp', 'tps']}, 19:33:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['damp', 'tps']}, 19:33:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:33:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:33:26 INFO - 'other': {'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'other_l64': {'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'other_nol64': {'tests': ['a11yr', 19:33:26 INFO - 'ts_paint', 19:33:26 INFO - 'tpaint', 19:33:26 INFO - 'sessionrestore', 19:33:26 INFO - 'sessionrestore_no_auto_restore']}, 19:33:26 INFO - 'svgr': {'tests': ['tsvgx', 19:33:26 INFO - 'tsvgr_opacity', 19:33:26 INFO - 'tart', 19:33:26 INFO - 'tscrollx', 19:33:26 INFO - 'cart']}, 19:33:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['tsvgx', 19:33:26 INFO - 'tsvgr_opacity', 19:33:26 INFO - 'tart', 19:33:26 INFO - 'tscrollx', 19:33:26 INFO - 'cart']}, 19:33:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'tests': ['tp5o']}, 19:33:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'talos_options': ['--e10s'], 19:33:26 INFO - 'tests': ['tp5o']}, 19:33:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'talos_options': ['--xperf_path', 19:33:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:26 INFO - 'tests': ['tp5n']}, 19:33:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:26 INFO - 'talos_options': ['--e10s', 19:33:26 INFO - '--xperf_path', 19:33:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:26 INFO - 'tests': ['tp5n']}}, 19:33:26 INFO - 'talos.zip': {'path': '', 19:33:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:33:26 INFO - Running post-action listener: _resource_record_post_action 19:33:26 INFO - ##### 19:33:26 INFO - ##### Running create-virtualenv step. 19:33:26 INFO - ##### 19:33:26 INFO - Running pre-action listener: _resource_record_pre_action 19:33:26 INFO - Running main action method: create_virtualenv 19:33:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:33:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:33:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:33:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:33:26 INFO - Using real prefix '/tools/python27' 19:33:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:33:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:33:30 INFO - Installing pip.................done. 19:33:30 INFO - Return code: 0 19:33:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:30 INFO - 'HOME': '/Users/cltbld', 19:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:30 INFO - 'LOGNAME': 'cltbld', 19:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:30 INFO - 'MOZ_NO_REMOTE': '1', 19:33:30 INFO - 'NO_EM_RESTART': '1', 19:33:30 INFO - 'PAGER': '/bin/cat', 19:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:30 INFO - 'PWD': '/builds/slave/test', 19:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:30 INFO - 'SHELL': '/bin/bash', 19:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:30 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:30 INFO - 'USER': 'cltbld', 19:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:30 INFO - 'XPC_FLAGS': '0x0', 19:33:30 INFO - 'XPC_SERVICE_NAME': '0', 19:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:33:30 INFO - Cleaning up... 19:33:30 INFO - Return code: 0 19:33:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 19:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 19:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:30 INFO - 'HOME': '/Users/cltbld', 19:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:30 INFO - 'LOGNAME': 'cltbld', 19:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:30 INFO - 'MOZ_NO_REMOTE': '1', 19:33:30 INFO - 'NO_EM_RESTART': '1', 19:33:30 INFO - 'PAGER': '/bin/cat', 19:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:30 INFO - 'PWD': '/builds/slave/test', 19:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:30 INFO - 'SHELL': '/bin/bash', 19:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:30 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:30 INFO - 'USER': 'cltbld', 19:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:30 INFO - 'XPC_FLAGS': '0x0', 19:33:30 INFO - 'XPC_SERVICE_NAME': '0', 19:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:30 INFO - Downloading/unpacking psutil>=0.7.1 19:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:33:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:32 INFO - Installing collected packages: psutil 19:33:32 INFO - Running setup.py install for psutil 19:33:32 INFO - building 'psutil._psutil_osx' extension 19:33:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:33:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:33:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:33:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:33:33 INFO - building 'psutil._psutil_posix' extension 19:33:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:33:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:33:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:33:33 INFO - ^ 19:33:33 INFO - 1 warning generated. 19:33:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:34 INFO - Successfully installed psutil 19:33:34 INFO - Cleaning up... 19:33:34 INFO - Return code: 0 19:33:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 19:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 19:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:34 INFO - 'HOME': '/Users/cltbld', 19:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:34 INFO - 'LOGNAME': 'cltbld', 19:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:34 INFO - 'MOZ_NO_REMOTE': '1', 19:33:34 INFO - 'NO_EM_RESTART': '1', 19:33:34 INFO - 'PAGER': '/bin/cat', 19:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:34 INFO - 'PWD': '/builds/slave/test', 19:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:34 INFO - 'SHELL': '/bin/bash', 19:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:34 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:34 INFO - 'USER': 'cltbld', 19:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:34 INFO - 'XPC_FLAGS': '0x0', 19:33:34 INFO - 'XPC_SERVICE_NAME': '0', 19:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:33:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:33:36 INFO - Installing collected packages: mozsystemmonitor 19:33:36 INFO - Running setup.py install for mozsystemmonitor 19:33:36 INFO - Successfully installed mozsystemmonitor 19:33:36 INFO - Cleaning up... 19:33:36 INFO - Return code: 0 19:33:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:33:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:36 INFO - 'HOME': '/Users/cltbld', 19:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:36 INFO - 'LOGNAME': 'cltbld', 19:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:36 INFO - 'MOZ_NO_REMOTE': '1', 19:33:36 INFO - 'NO_EM_RESTART': '1', 19:33:36 INFO - 'PAGER': '/bin/cat', 19:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:36 INFO - 'PWD': '/builds/slave/test', 19:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:36 INFO - 'SHELL': '/bin/bash', 19:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:36 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:36 INFO - 'USER': 'cltbld', 19:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:36 INFO - 'XPC_FLAGS': '0x0', 19:33:36 INFO - 'XPC_SERVICE_NAME': '0', 19:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:33:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:40 INFO - Downloading docopt-0.6.1.tar.gz 19:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:33:40 INFO - Running setup.py install for blobuploader 19:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:33:40 INFO - Running setup.py install for requests 19:33:41 INFO - Running setup.py install for docopt 19:33:41 INFO - Successfully installed blobuploader requests docopt 19:33:41 INFO - Cleaning up... 19:33:41 INFO - Return code: 0 19:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:41 INFO - 'HOME': '/Users/cltbld', 19:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:41 INFO - 'LOGNAME': 'cltbld', 19:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:41 INFO - 'MOZ_NO_REMOTE': '1', 19:33:41 INFO - 'NO_EM_RESTART': '1', 19:33:41 INFO - 'PAGER': '/bin/cat', 19:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:41 INFO - 'PWD': '/builds/slave/test', 19:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:41 INFO - 'SHELL': '/bin/bash', 19:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:41 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:41 INFO - 'USER': 'cltbld', 19:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:41 INFO - 'XPC_FLAGS': '0x0', 19:33:41 INFO - 'XPC_SERVICE_NAME': '0', 19:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-NJvtRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-cy2Scn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-UuuBOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-SyVSU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-2z1CXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-rMardN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-TSGKXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-tR8dgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-gZNAIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-f9erRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-3q6bWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-0q845E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-h4izm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:43 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-maZ7kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:43 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-GxIVrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:43 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-tclnG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:43 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-gCVBag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:33:43 INFO - Running setup.py install for manifestparser 19:33:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozcrash 19:33:43 INFO - Running setup.py install for mozdebug 19:33:43 INFO - Running setup.py install for mozdevice 19:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Running setup.py install for mozfile 19:33:44 INFO - Running setup.py install for mozhttpd 19:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Running setup.py install for mozinfo 19:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Running setup.py install for mozInstall 19:33:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Running setup.py install for mozleak 19:33:44 INFO - Running setup.py install for mozlog 19:33:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Running setup.py install for moznetwork 19:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Running setup.py install for mozprocess 19:33:45 INFO - Running setup.py install for mozprofile 19:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Running setup.py install for mozrunner 19:33:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Running setup.py install for mozscreenshot 19:33:45 INFO - Running setup.py install for moztest 19:33:45 INFO - Running setup.py install for mozversion 19:33:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:33:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:33:45 INFO - Cleaning up... 19:33:45 INFO - Return code: 0 19:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:45 INFO - 'HOME': '/Users/cltbld', 19:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:45 INFO - 'LOGNAME': 'cltbld', 19:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:45 INFO - 'MOZ_NO_REMOTE': '1', 19:33:45 INFO - 'NO_EM_RESTART': '1', 19:33:45 INFO - 'PAGER': '/bin/cat', 19:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:45 INFO - 'PWD': '/builds/slave/test', 19:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:45 INFO - 'SHELL': '/bin/bash', 19:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:45 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:45 INFO - 'USER': 'cltbld', 19:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:45 INFO - 'XPC_FLAGS': '0x0', 19:33:45 INFO - 'XPC_SERVICE_NAME': '0', 19:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-NtLX97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-aDS_dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-wWV6VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-8Df21e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-tW5fiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-YN0Mrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-443bU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:46 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-_GAgk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-8WEodF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-9ZszH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Y1bNNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-WJUV2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-CxRV0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-ITzt8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-uoWspi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-o4VaN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:47 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-KcK1nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:48 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:48 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:50 INFO - Downloading blessings-1.5.1.tar.gz 19:33:50 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:33:50 INFO - Installing collected packages: blessings 19:33:50 INFO - Running setup.py install for blessings 19:33:50 INFO - Successfully installed blessings 19:33:50 INFO - Cleaning up... 19:33:50 INFO - Return code: 0 19:33:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:50 INFO - Reading from file tmpfile_stdout 19:33:50 INFO - Current package versions: 19:33:50 INFO - blessings == 1.5.1 19:33:50 INFO - blobuploader == 1.2.4 19:33:50 INFO - docopt == 0.6.1 19:33:50 INFO - manifestparser == 1.1 19:33:50 INFO - mozInstall == 1.12 19:33:50 INFO - mozcrash == 0.16 19:33:50 INFO - mozdebug == 0.1 19:33:50 INFO - mozdevice == 0.47 19:33:50 INFO - mozfile == 1.2 19:33:50 INFO - mozhttpd == 0.7 19:33:50 INFO - mozinfo == 0.9 19:33:50 INFO - mozleak == 0.1 19:33:50 INFO - mozlog == 3.0 19:33:50 INFO - moznetwork == 0.27 19:33:50 INFO - mozprocess == 0.22 19:33:50 INFO - mozprofile == 0.27 19:33:50 INFO - mozrunner == 6.11 19:33:50 INFO - mozscreenshot == 0.1 19:33:50 INFO - mozsystemmonitor == 0.0 19:33:50 INFO - moztest == 0.7 19:33:50 INFO - mozversion == 1.4 19:33:50 INFO - psutil == 3.1.1 19:33:50 INFO - requests == 1.2.3 19:33:50 INFO - wsgiref == 0.1.2 19:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10e599490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e576228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae1c8ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, '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.uv5lCZySi9/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.jB2YvOBOVn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:33:50 INFO - 'HOME': '/Users/cltbld', 19:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:33:50 INFO - 'LOGNAME': 'cltbld', 19:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:50 INFO - 'MOZ_NO_REMOTE': '1', 19:33:50 INFO - 'NO_EM_RESTART': '1', 19:33:50 INFO - 'PAGER': '/bin/cat', 19:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:50 INFO - 'PWD': '/builds/slave/test', 19:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:33:50 INFO - 'SHELL': '/bin/bash', 19:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:33:50 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:33:50 INFO - 'USER': 'cltbld', 19:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:50 INFO - 'XPC_FLAGS': '0x0', 19:33:50 INFO - 'XPC_SERVICE_NAME': '0', 19:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:51 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 1)) 19:33:51 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 2)) 19:33:51 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 3)) 19:33:51 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 4)) 19:33:51 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 5)) 19:33:51 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 6)) 19:33:51 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 7)) 19:33:51 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 8)) 19:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:51 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 3)) 19:33:51 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:51 INFO - Cleaning up... 19:33:51 INFO - Return code: 0 19:33:51 INFO - Running post-action listener: _resource_record_post_action 19:33:51 INFO - Running post-action listener: _start_resource_monitoring 19:33:51 INFO - Starting resource monitoring. 19:33:51 INFO - ##### 19:33:51 INFO - ##### Running install step. 19:33:51 INFO - ##### 19:33:51 INFO - Running pre-action listener: _resource_record_pre_action 19:33:51 INFO - Running main action method: install 19:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:51 INFO - Reading from file tmpfile_stdout 19:33:51 INFO - Detecting whether we're running mozinstall >=1.0... 19:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:33:51 INFO - Reading from file tmpfile_stdout 19:33:51 INFO - Output received: 19:33:51 INFO - Usage: mozinstall [options] installer 19:33:51 INFO - Options: 19:33:51 INFO - -h, --help show this help message and exit 19:33:51 INFO - -d DEST, --destination=DEST 19:33:51 INFO - Directory to install application into. [default: 19:33:51 INFO - "/builds/slave/test"] 19:33:51 INFO - --app=APP Application being installed. [default: firefox] 19:33:51 INFO - mkdir: /builds/slave/test/build/application 19:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:34:22 INFO - Reading from file tmpfile_stdout 19:34:22 INFO - Output received: 19:34:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:34:22 INFO - Running post-action listener: _resource_record_post_action 19:34:22 INFO - ##### 19:34:22 INFO - ##### Running run-tests step. 19:34:22 INFO - ##### 19:34:22 INFO - Running pre-action listener: _resource_record_pre_action 19:34:22 INFO - Running main action method: run_tests 19:34:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:34:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:34:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:34:22 INFO - 2015-11-20 19:34:22.124 screenresolution[1645:7697] starting screenresolution argv=screenresolution get 19:34:22 INFO - 2015-11-20 19:34:22.126 screenresolution[1645:7697] Display 0: 1600x1200x32@60 19:34:22 INFO - 2015-11-20 19:34:22.131 screenresolution[1646:7700] starting screenresolution argv=screenresolution list 19:34:22 INFO - Available Modes on Display 0 19:34:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:34:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:34:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:34:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:34:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:34:22 INFO - Intel Iris: 19:34:22 INFO - Chipset Model: Intel Iris 19:34:22 INFO - Type: GPU 19:34:22 INFO - Bus: Built-In 19:34:22 INFO - VRAM (Dynamic, Max): 1536 MB 19:34:22 INFO - Vendor: Intel (0x8086) 19:34:22 INFO - Device ID: 0x0a2e 19:34:22 INFO - Revision ID: 0x0009 19:34:22 INFO - Displays: 19:34:22 INFO - Display: 19:34:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:34:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:34:22 INFO - Display Serial Number: 1600x1200 60 19:34:22 INFO - Main Display: Yes 19:34:22 INFO - Mirror: Off 19:34:22 INFO - Online: Yes 19:34:22 INFO - Rotation: Supported 19:34:22 INFO - Return code: 0 19:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:34:22 INFO - Python 2.7.3 19:34:22 INFO - Return code: 0 19:34:22 INFO - grabbing minidump binary from tooltool 19:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:34:22 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4bd9f0>, '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 0x10e21cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b08c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:34:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:34:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:34:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:34:22 INFO - Return code: 0 19:34:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:34:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--webServer', 'localhost'] in /builds/slave/test/build 19:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0044 --webServer localhost 19:34:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uv5lCZySi9/Render', 19:34:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:22 INFO - 'HOME': '/Users/cltbld', 19:34:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:22 INFO - 'LOGNAME': 'cltbld', 19:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:22 INFO - 'MOZ_NO_REMOTE': '1', 19:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:34:22 INFO - 'NO_EM_RESTART': '1', 19:34:22 INFO - 'PAGER': '/bin/cat', 19:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:22 INFO - 'PWD': '/builds/slave/test', 19:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:34:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:22 INFO - 'SHELL': '/bin/bash', 19:34:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB2YvOBOVn/Listeners', 19:34:22 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 19:34:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:22 INFO - 'USER': 'cltbld', 19:34:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:22 INFO - 'XPC_FLAGS': '0x0', 19:34:22 INFO - 'XPC_SERVICE_NAME': '0', 19:34:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--webServer', 'localhost'] with output_timeout 3600 19:34:22 INFO - mozversion INFO | application_buildid: 20151120175133 19:34:22 INFO - mozversion INFO | application_changeset: 3929c7bc30e88d9c12c6cda017dde930eb7ff3c5 19:34:22 INFO - mozversion INFO | application_display_name: Nightly 19:34:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:34:22 INFO - mozversion INFO | application_name: Firefox 19:34:22 INFO - mozversion INFO | application_remotingname: firefox 19:34:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:34:22 INFO - mozversion INFO | application_vendor: Mozilla 19:34:22 INFO - mozversion INFO | application_version: 45.0a1 19:34:22 INFO - mozversion INFO | platform_buildid: 20151120175133 19:34:22 INFO - mozversion INFO | platform_changeset: 3929c7bc30e88d9c12c6cda017dde930eb7ff3c5 19:34:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:34:22 INFO - mozversion INFO | platform_version: 45.0a1 19:34:22 INFO - 2015-11-20 19:34:22,675 DEBUG : using testdate: 1448076862 19:34:22 INFO - 2015-11-20 19:34:22,675 DEBUG : actual date: 1448076862 19:34:22 INFO - 2015-11-20 19:34:22,687 INFO : starting webserver on 'localhost:49274' 19:34:22 INFO - 2015-11-20 19:34:22,688 INFO : Starting test suite t-yosemite-r7-0044 19:34:22 INFO - 2015-11-20 19:34:22,688 INFO : Starting test dromaeo_css 19:34:22 INFO - 2015-11-20 19:34:22,688 DEBUG : operating with platform_type : mac_ 19:34:22 INFO - 2015-11-20 19:34:22,688 INFO : Initialising browser for dromaeo_css test... 19:34:22 INFO - 2015-11-20 19:34:22,701 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpTILMf9/profile http://localhost:49274/getInfo.html 19:34:24 INFO - 2015-11-20 19:34:24,847 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:34:24 INFO - 2015-11-20 19:34:24,848 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:34:24 INFO - 2015-11-20 19:34:24,848 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:34:24 INFO - 2015-11-20 19:34:24,848 DEBUG : BROWSER_OUTPUT: __metrics 19:34:24 INFO - 2015-11-20 19:34:24,864 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:34:25 INFO - 2015-11-20 19:34:25,494 INFO : Browser initialized. 19:34:25 INFO - 2015-11-20 19:34:25,494 INFO : Running cycle 1/1 for dromaeo_css test... 19:34:25 INFO - 2015-11-20 19:34:25,494 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpTILMf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:34:37 INFO - 2015-11-20 19:34:37,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 226439168 19:34:37 INFO - 2015-11-20 19:34:37,354 DEBUG : BROWSER_OUTPUT: 19:35:28 INFO - 2015-11-20 19:35:28,528 DEBUG : BROWSER_OUTPUT: 1448076928522 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:37:39 INFO - 2015-11-20 19:37:39,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 19:37:41 INFO - 2015-11-20 19:37:41,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 360099840 19:37:41 INFO - 2015-11-20 19:37:41,232 DEBUG : BROWSER_OUTPUT: 19:40:43 INFO - 2015-11-20 19:40:43,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 19:40:44 INFO - 2015-11-20 19:40:44,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 366886912 19:40:44 INFO - 2015-11-20 19:40:44,460 DEBUG : BROWSER_OUTPUT: 19:43:46 INFO - 2015-11-20 19:43:46,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 19:43:47 INFO - 2015-11-20 19:43:47,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 362442752 19:43:47 INFO - 2015-11-20 19:43:47,144 DEBUG : BROWSER_OUTPUT: 19:46:49 INFO - 2015-11-20 19:46:49,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 19:46:49 INFO - 2015-11-20 19:46:49,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 328155136 19:46:49 INFO - 2015-11-20 19:46:49,799 DEBUG : BROWSER_OUTPUT: 19:49:52 INFO - 2015-11-20 19:49:52,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 19:49:53 INFO - 2015-11-20 19:49:53,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 326881280 19:49:53 INFO - 2015-11-20 19:49:53,465 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:52:56 INFO - 2015-11-20 19:52:56,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 374112256 19:52:56 INFO - 2015-11-20 19:52:56,540 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,541 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:52:56 INFO - 2015-11-20 19:52:56,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:52:56 INFO - 2015-11-20 19:52:56,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:52:56 INFO - 2015-11-20 19:52:56,541 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:52:56 INFO - 2015-11-20 19:52:56,541 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3435.70796482299;3525.82370881456;3536.9646303536956;3553.3426316131536;3582.319359321729;4410.360497727827;5479.205515200293;5747.885042299152;5865.296164460271;6045.304789949158;5963.612365196259;5995.550333724967;6031.638101713889;6158.107074474198;6170.876582468359;5318.973405132969;5357.892842143155;5358.4641535846295;5370.355557333126;5439.755211015494;5481.972590137064;5485.451454854522;5511.173324001412;5526.336839579256;5550.750216240259;5206.843794686184;5321.494458026481;5330.253764472977;5335.413104558495;5413;5261.4738526147075;5332.813351532678;5371.785128594852;5376.78492860289;5384.838454846361;5338.492843179892;5364.141737322048;5366.141417373241;5373.650712703662;5378.193271009341;5759.107338362561;5941.405859414067;5947.316058653267;5965.105234214859;5980.940190598082;6244.87510249797;6264.906026409608;6268.059791031336;6395.42441180296;6414.871702565969;6439.742410303582;6450.903236451457;6461.483081353527;6484.967575162094;6491.091247225392;5897.587168898136;6064.36324185963;6133.355997620275;6136.938630613681;6140.6929653517145;6339.619622822645;6436.645984470899;6495.805125846232;6497.642629655415;6511.804645860631;6053.697315134225;6174.969125154345;6176.166217560572;6185.288691800501;6189.535784816157;6394.488440924715;6416.454601358937;6426.710798014101;6430.131932189188;6438.452731517874;6138.199401565478;6249.906266403361;6280.214973128359;6368.4586810121655;6370.58591191571;6159.168512250879;6206.441420272107;6243.8126856194385;6325;6352.364763523703;5118.59051275897;5125.1287281162295;5132.666376685504;5134.948650513522;5166.276721259027;4286.292761694348;4554.521775213555;4609.8156073757345;4617.676762626584;4651.976740116278;5947.851303717355;5953.315368732651;6004.099385092184;6062.514054418727;6122.112293717386;5565.443455654483;6221.724546467964;6427.485801135991;6431.163948686641;6439.291677915426;5759.913601295984;6039.577229593974;6041.8489537761025;6052.576319657582;6057.091436284592;5483.424240454775;5540.36285827127;5565.554755619541;5570.3315602128005;5589.077802162679;6256.718447669957;6300.684965751786;6325.272593651697;6340.1123842661145;6346.650934198663;5374.946250537445;6423.100765892686;6428.582142160744;6440.066190402459;6442.935570644421;6400.871982560416;6418.871622567429;6420.357964203542;6428.453581445629;6447.065175549613;5555.3611334697025;6047.911375952371;6216.689165541795;6306.621602703853;6325.936740632719;6383.0744542042075;6392.776252831129;6405.519586030973;6408.967955160194;6410.1025856381075;5451.373092094302;5630.071038278638;6343.841403964938;6354.7140378684;6363.6818159090935;6114.938850611615;6142.989934931762;6202.038684003986;6220.533459990428;6329.556931014785;6159.476444502088;6226.750929962932;6227.06594010902;6233.657148856856;6248.750049998131;5501.752421140978;6131.662758548323;6324.905126423016;6336.081268216175;6349.428551430394;5133.8716532087;5956.791512297049;6077.6961151943115;6089.299730530868;6260.436560709558 19:52:56 INFO - 2015-11-20 19:52:56,542 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.464109813481;573.9081746920493;587.166223961974;612.9478994285486;638.0206383201786;32324.838375808118;32834.34331313372;42420;42733.57266427335;42735.57264427355;45708.54291457085;45951.080978380494;45951.77024114883;45954.31068533975;45959;9798.951005244964;10011.449370284632;10013.449260290681;10023.148032417253;10059.748506287366;8272.379571532128;9901.603935842557;9911.405315681046;9913.702588922344;9918;9858;9922.652707155252;9932.95033524835;9933.652322168726;9936.701898943043;9844.458554779485;9933.403995760205;9935.10584047432;9939.304248702594;9942.30403871722;9789.657361992297;9891.604335826558;9896.752581185456;9900.851487227625;9903.702888913343;42147.367789483185;42547.361789572875;42620.57379426228;42645;42647.720568382996;2859.6711378191358;3224.274538228903;3254.479283314682;3296.2089098616398;3353.9099792567267;29245.68394422235;29608.851955740298;29961.850190749126;30146.397072058437;30206.84896575525;2730.180945716297;2799.1882354117283;2808.985955070232;2819.9989003903524;2923.780716446275;451760;476238;487119;490026;490900.5454972738;50226.49773502292;63243.68378158172;63363.366366335744;68767.96848047283;72533.637331813;71372.28627713761;71402.64298678577;71560.28439715537;71568;71707.28292717111;16773.24520396585;17144;17164.742528862076;17178.914105429394;17186.91406542959;11806.46870890812;11995.700107497209;12235;12902.161359511601;12955.740885182244;22003.449913752283;22595.774042259694;22611.547769044526;22616.660750088762;22630.547389052128;9459.195968342769;9726.173275271682;9762.414255144715;9763.658271960589;9778.511074446249;943.6508491858057;957.1863915671762;990.2424645146468;1027.9280450368403;1030.4332617060586;30311.696883030887;30468;30668.69331306703;31195.688043119277;31350;1077.21363404715;1077.3912739302425;1112.3048094940661;1126.723952631594;1141.1213365708359;14374.712505750036;14532.782008269884;14557;14836.480723174636;14863.18252496123;548712;548889;549804;550404;551756.1709723072;60092.69953650204;60390.39609603935;60485;60488.395116049156;60552.69723651354;1263.9936800316123;1476.2028504607392;1495.2673190136973;1496.4313560847027;1501.5420296809577;28937.56593651139;29321.85339073291;30744.692553074183;30770.846145769126;31504.36991260116;53067.20399194092;53346.46653533415;53483.46516534785;53515;53610.65973350542;455083;457085;457325;459042;459747;27736.58395124115;32360.6021367753;33274.33451331008;33571;33591.832040840614;45209.32186017147;45828;46060.30909536293;46299.768501157276;46979.295310571055;38215.80892095522;38359.42460863145;39064;39136;39318.60681393264;29743.702562974093;37811.865644030724;38065.61934380732;38490.615093849825;38676.80661596674;34386.82806585951;35183.19394663399;35939.820300898326;36532.269354612225;36717.63282367249;31754.523682144325;34061.14847128842;34492.65507344894;34501.82749086339;34589.13527161841;25456.745432546177;25678.614820778075;25716;25738.742612574384;26287.21138365852 19:52:56 INFO - 2015-11-20 19:52:56,546 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.3427824246902;355.26814761591123;355.3745408081775;357.3478401916502;360.2003552114305;15716.921415392908;15888.841111588881;19630.509237269056;20574.794252057476;21347.466313342175;16656.75014874775;20116.59766804663;20490.487737806525;20587.897060514675;20592.79407205931;5419.458054194579;5768.913466297988;5768.942310576904;5770.307563092414;5770.653760774346;3038.9392212155744;4174.874753757377;4303.332983387564;5798.797042103527;5813.709314534278;5133.691978481284;6213.751449941997;6219.378062193767;6219.906701399483;6226.190595222637;6080.787172448965;6141.078838174287;6207.068939659065;6238.875222495525;6240.157578726859;5341.385740639837;5346.465353464661;5348.946510534884;5350.866228344284;5353.973230133864;25365.746342536524;25796.61305080425;25894.352641183934;25990.480190396087;26137.215883523524;2066.245820275604;2153.5800518898823;2169.642009068502;2336.2290444153386;2350.048230466664;14559.636009099751;14590.197539135343;14774.48289309869;15153.939224254307;15322.616934576614;1708.5386945524763;1744.2325376834153;1754.9034803085826;1785.7857057153094;1789.4899953513186;93986.06013939841;97538.51230743872;97829;98683;99401;9883.369244074791;10091.394516329045;10281;10291;10296;12504.437300321508;12524.624261271994;12527.43626536808;12527.874721252852;12537.811932821014;8509.574521273911;8520.616572254263;8526.147385261424;8571.271441927505;8590.312774977987;7194.424446044304;8852.247558957431;8887.644494220158;8957.417767845069;8980.955095224483;6124.540659450559;6133.233345831771;6142.416470435302;6154.876902461926;6164.4143806338325;1551.5422950229708;1621.6189195539039;1703.5485596316985;1715;1751.8948863068256;816.6406781016452;951.8714973478492;1033.6227277043824;1036.1917704190744;1064.5582083435443;11642.301461912313;11900.761984760256;11911.76176476483;20724.689129663067;21163.25928592492;426.54572879883443;430.77814925313487;433.8438162261583;438.44098774063326;447.86564030790635;5959.748090047322;6115.143879856823;6181.567290289637;6191.133241346215;6194.566380353332;756147;756424;758006.2099689466;762164;770383;84552;128566.00455617139;131427;131469.68530314765;133946;383.38083994348926;405.61669222584965;490.0493043495607;490.5805536266441;491.40785353648766;11150.275232109887;18875.056247187862;20032.899835500728;20229.88735619555;20365.389038328874;56587;57399;57410;57882.421175787706;57889.42110579009;73502.63248683722;73545.8968115468;73972;74887.8766818509;77949.61025194838;10038.698839034842;10050.195984321383;10275.075243228146;10287.53706083213;10365.222608304559;20386.898065509577;20441.897790510953;20640.58718825645;21110;21190;11388.772224555296;14146.363413646204;16169.434069807501;16328.346866125697;16742.58143546421;15380.38478460849;15423.537293881202;15809.288582013607;16162.595935101717;16433.835661643232;13042;13136.474541018635;16264.430744923871;16288.429904953744;16805.579860503585;9819.509024548886;10010;10038.749031274276;10054.798904021733;10062.69811905644;10389.636362727268;11613.825792613286;14087.15477071338;16079.27643256033;16289.837101628833 19:52:56 INFO - 2015-11-20 19:52:56,547 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1561.2193903048474;1723.6121872578678;1771.902545360005;1986.1856638778104;2042.5506388594504;7574.091109066912;7980.321672657824;8233.629486673099;8314.334853211743;8360.080391156984;8408.117147699495;8526.616302266397;8550.486970781758;8570.914290857105;8571.442856214357;2090.456481314854;2182.4216582605623;2382.4520360317138;2403.170906037423;2408.2654790288957;2198.362474882282;2382.4282172278613;2414.1550457339968;2415.2271273192587;2417.504411595619;2331.440454290975;2366.2664573982033;2366.8698221597892;2375.7861792438675;2385.689860318156;2132.0618927671853;2195.1768086967386;2348.248560460653;2378.6788783514176;2408.1330720940446;2368.7749663781915;2374.536965291769;2376.6791483149727;2378.4886249456276;2379.654950032253;8428.915710842874;8581.828363432758;8592.828143437158;8596.269317108054;8608.52653104079;5144.356955380577;5233.764480598382;5250.369955605352;5253.448387919251;5269.1832765921345;3506.8597256109724;3523.066387407339;3602.351576716216;3606.495090687306;3626.256617393428;1024.5748014573942;1026.9537870795832;1054.6361505280743;1060.496264274471;1062.2245760594733;11366.829497557543;11382.60160894373;11385.430728463543;11388.60139895108;11424.485898134604;4674.795753033733;4720.669553131248;4739.644526660514;4743.454502732161;4786.497417771154;9664.951675241578;9770.804583908424;9786;9795.167410770022;9807.558659860324;5188.766505507261;5215.556677682363;5226.895462090737;5243.1873059675045;5248.343957005374;4785.545373189541;4828.686135401258;4842.322074909445;4842.782074806642;4843.346148269939;3453.792772433662;3667;3842.7502212356108;3892.3966785148345;3929.1945151243926;1282.1089342906591;1285.2609749394135;1293.502001729341;1297.935103244834;1317.0583033131356;1062.4740753327153;1085.582050910405;1085.7394225385851;1269.225772278909;1418.14202407544;7852.057753069668;7908.406869484812;7963.482373645695;7987.281144697005;8006.599670016476;496.63993604637074;507.66747780204025;512.9102407078747;515.2786099460785;516.0298638559484;5096.974515127475;5846.093855452412;5985.042393217152;6002.159697642333;6363.809085727436;10108.39349639024;10206.489675516195;10297.12474439681;10357.585696572203;10412.479376031168;10254.743631409274;10264.127549158256;10264.230182736324;10268.691939241835;10273.9486302568;7863.174366691415;8000.839983200303;8014.959925200336;8104;8114.634841432032;7798;7861;7887.566183859943;7893.210678932061;7908.960455197687;9054.954725226331;9087.954560227157;9117.5441227937;9162.221211197122;9233.49215793111;9317.627294908129;9460.243180545402;9599.47202903847;9606.855897161407;9607.423554586747;7231.63841807918;7269.091363579552;7293.562386256842;7294.307040831112;7304.853902922018;7979.640916158903;8036.799080023046;8074.959625201836;8094.3929205311015;8121.309688676292;7521.849563008818;7543.660535275816;7623.313901748869;7647.311741943252;7700.229977002255;6325.8734825304155;7438.107427108782;7509.6245187739305;7539.660715267716;7572.621368931421;7439.702411903463;7554.131274903457;7601.619919004138;7616;7720.652570634447;6981.476389270927;7026.578405295699;7029.824254393681;7031.824204394931;7036.19083805369;6381.521385895983;6436.098946147449;7120.2167761547225;7151.642417878981;7155.069840920647 19:52:56 INFO - 2015-11-20 19:52:56,548 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.4841308666873;321.3027729826278;327.5038316949821;331.150598714298;336.31559775856135;6592.208934927803;6708.060871477997;6709.731610735571;6736.831579210516;6754.696038678265;6578.309277525863;6691.130153080105;6740.966295168518;6762.526623136382;6809.387155156035;4987.775550100254;5034.1945288753805;5038.244263360489;5038.7984480620735;5052.343195384595;4705.1530724469585;4760.857174284777;4892.77982490787;5022.6233032522705;5039.269305950635;3974.4237085622567;4929.4824043475455;4951.55436010759;4970.179920313144;4974.87562810929;4008.5790991945864;5010.774515146827;5010.924836127461;5017.849464516052;5018.447970723254;4262.808173632194;4263.296556068245;4269.914601707979;4270.572942705736;4272.551382104896;6247.843803904893;6446.709898054599;6449.54853160279;6487.221533415973;6517.51118666102;4935.9753201234125;5838.97817881869;5907.350191478934;5926.911096333559;5948.13752005961;5745.2476994516655;7197.568145911262;7261.056062711867;7271.0547628808445;7271.745488907915;4515.977420112911;4674.672772905898;4679.204535229019;4781.641376896747;4797.784099715486;6217.4715149212825;7668.769936901902;7747.883781743279;7762.805929851799;7766.689332426696;3886.7473614214987;4503.639708823286;4730.692504987165;4733.786979585927;4736.621070314367;3805.6765174959883;4673.883152921137;4673.929891051637;4676.672632915664;4696.272077827942;5551.000819852466;5656.971715141481;5768;5816.098504731774;5816.360200377955;6207.751689932352;7341.119065712042;7351.411887049023;7352.669129889167;7371.594562299125;1599.4002249156567;1657.6353202295475;1674.2382216091648;1674.8660107191395;1678.261564911435;876.9956150219208;1060.5174645536263;1062.8512008318842;1066.8346406307035;1067.3435836960368;6710.630915299607;6744.089547911068;6747.156605424322;6754;6774;7575.848483030419;7577;7580.3556697681315;7581.355584775246;7582.582957937256;6466.482681385478;6710.9262517996885;6736.7642132525125;6754.3921047106;6758.121444212221;3990.2618015667194;4035.1841671248058;4037.2531081749385;4041.5756345583877;4042.2521833460905;7610.733624323122;7613.6573854176695;7623;7623.809404764926;7632;6349.936500635027;7542.245775422523;7843.254890785366;7853.764387068397;7854.136045035041;7582.393408527305;7585.924140758632;7588.582627955516;7597.696092156252;7599.01212842327;6560.3111673273615;7432.591207483641;7535.095788505414;7554;7564.167941526538;5979.4618484336615;7150.749723759852;7454.92545074564;7461;7461.328480436787;7598.772036838683;7600.657970391235;7603.201663825219;7603.847923041619;7620.657070431955;4545.931811022903;4632.3977882875015;4644.9767751161025;4653.883652908705;4749.503906269514;6535.790878687458;7067.681954312171;7536.020317358928;7585.065808218869;7586.9620651898595;7256;7256.4194864409665;7273.236310187354;7303.196648368569;7306.305900939402;7065.434765218873;7233.529820561646;7242.420606351585;7254;7313.414926805949;7142.142942846892;7151.356377926011;7164.749233776793;7168.498205125591;7170.42636589082;7176.923461480819;7313.707451702086;7323.194448610542;7361.411087113125;7370.926290737024;5772.94227057724;7183.425325973805;7186.532875363085;7211.2428195038765;7214.098237720285 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.2269616902252;773.5629369406284;775.9534427934325;812.4353574265884;835.1606635331491;14946.5516034519;15448.918575699692;15478.61303467411;15481.071135731863;15485.14831684257;14182.787258191136;14270.2864856757;14286.928565357159;14289.499867504639;14320.498782542612;749.3068911257106;764.0716529416758;765.5827573972199;768.4927947554615;947.1712251779693;948.33616468472;951.5908159491416;967.632299726103;968.6803354892868;969.3505351414569;1008.7881544875548;1019.5564929255761;1022.2588623248123;1023.4166525080707;1024.6311327921978;797.4736673795296;810.7648781853255;811.6347643560422;992.7369247149511;1004.5931397783909;753.8567672142275;757.8105473631592;759.3128218961848;760.2017881224747;762.0702742654008;14840.480583179537;15000.399984000627;15007.099574025593;15018.174000429972;15032.17323047232;12330.63008109758;12791.104622676416;12807.231566106064;12941;12967.416466259041;8368.958155209186;8403.327733781283;10086.848697269546;10177.236707246986;10233.64182253625;3563.429851223792;3635.4001589737663;3645.325614761278;3658.176910195185;3792.4500947362753;77183.84224236642;78019;79840;79912.00219994488;80062.19937800606;9596.280278979104;9636.46999415039;9674.08096230857;9797.412155270707;9924.255680823822;22066.66899996501;22067;22074.88962555177;22081;22120.44698882541;7434.293742094493;7565.773026809205;7636.121845987783;7816.022997125359;7826.295633393022;3484.7038001770134;4018.9799051005143;4098.610631989956;4103.4050062741335;4112.054227527626;3471.600765911902;3512.2448673535314;3515.455104458813;3521.207728261121;3525.1715846775987;613.4601550635501;629.719774700254;631.2204427532087;647.8153726188013;649.6459429610874;534.7993754022245;573.4724053870449;578.4302462074853;609.135028259872;618.2426527503771;9012.233960113334;9057.637694492278;9228.676996305232;9315.956041765388;9394.389364691273;502.8290381270386;522.7699812082672;601.7472661482188;618.153130211613;620.4973971083436;3920.5099362579676;4007.479027726377;4011.13760541485;4125.91748165041;4151.445362134687;92257;93721.53139234397;93767;94039;94518.5274073639;65145;69581.95627065598;80936.19063809287;84036.57981710053;85162;72143.55712885712;72243.99999999895;73208;73268;73711;8096.352291816758;8124.512529248264;8225.177482251727;8260.83478330442;8417.368697347845;41180.79409602933;48581;50109.997800044526;51361.74319128381;51643;67989.64020719657;72856.63571682108;73132.63433682798;73257;74858.62570687111;8904.55477226149;9712.5143742814;10080.99190080986;10396.272260941661;10538.367697938149;9906.900930990887;11049.01075119389;11069.5018724156;12113.878861211628;12156.939215303866;9928.751781205528;10308.622651541173;10395.376277423378;10609.416482093558;10766.623168189075;9989.350692204984;10570.630027948984;10589.841152382567;11066.502007409525;11249.1563132767;10969.670909872717;11029.393383363991;11241.81841586692;11478.138530283091;12119.620165335298;7696.961515192388;9677.516124193622;9748.366356186825;9997.500124993576;10107.595696172071;8652.913470865211;9838.9016109838;10036.397816131055;10037.247206459691;10171.64399246023 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1274 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1448077976537__endTimestamp 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,552 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5871.12 Median:6122.11 stddev:643.77 (10.5%) stddev-sans-first:616.74 19:52:56 INFO - 2015-11-20 19:52:56,553 DEBUG : BROWSER_OUTPUT: Values: 3435.7 3525.8 3537.0 3553.3 3582.3 4410.4 5479.2 5747.9 5865.3 6045.3 5963.6 5995.6 6031.6 6158.1 6170.9 5319.0 5357.9 5358.5 5370.4 5439.8 5482.0 5485.5 5511.2 5526.3 5550.8 5206.8 5321.5 5330.3 5335.4 5413.0 5261.5 5332.8 5371.8 5376.8 5384.8 5338.5 5364.1 5366.1 5373.7 5378.2 5759.1 5941.4 5947.3 5965.1 5980.9 6244.9 6264.9 6268.1 6395.4 6414.9 6439.7 6450.9 6461.5 6485.0 6491.1 5897.6 6064.4 6133.4 6136.9 6140.7 6339.6 6436.6 6495.8 6497.6 6511.8 6053.7 6175.0 6176.2 6185.3 6189.5 6394.5 6416.5 6426.7 6430.1 6438.5 6138.2 6249.9 6280.2 6368.5 6370.6 6159.2 6206.4 6243.8 6325.0 6352.4 5118.6 5125.1 5132.7 5134.9 5166.3 4286.3 4554.5 4609.8 4617.7 4652.0 5947.9 5953.3 6004.1 6062.5 6122.1 5565.4 6221.7 6427.5 6431.2 6439.3 5759.9 6039.6 6041.8 6052.6 6057.1 5483.4 5540.4 5565.6 5570.3 5589.1 6256.7 6300.7 6325.3 6340.1 6346.7 5374.9 6423.1 6428.6 6440.1 6442.9 6400.9 6418.9 6420.4 6428.5 6447.1 5555.4 6047.9 6216.7 6306.6 6325.9 6383.1 6392.8 6405.5 6409.0 6410.1 5451.4 5630.1 6343.8 6354.7 6363.7 6114.9 6143.0 6202.0 6220.5 6329.6 6159.5 6226.8 6227.1 6233.7 6248.8 5501.8 6131.7 6324.9 6336.1 6349.4 5133.9 5956.8 6077.7 6089.3 6260.4 19:52:56 INFO - 2015-11-20 19:52:56,553 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,553 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64953.97 Median:39100.00 stddev:132088.11 (337.8%) stddev-sans-first:132370.15 19:52:56 INFO - 2015-11-20 19:52:56,554 DEBUG : BROWSER_OUTPUT: Values: 552.5 573.9 587.2 612.9 638.0 32324.8 32834.3 42420.0 42733.6 42735.6 45708.5 45951.1 45951.8 45954.3 45959.0 9799.0 10011.4 10013.4 10023.1 10059.7 8272.4 9901.6 9911.4 9913.7 9918.0 9858.0 9922.7 9933.0 9933.7 9936.7 9844.5 9933.4 9935.1 9939.3 9942.3 9789.7 9891.6 9896.8 9900.9 9903.7 42147.4 42547.4 42620.6 42645.0 42647.7 2859.7 3224.3 3254.5 3296.2 3353.9 29245.7 29608.9 29961.9 30146.4 30206.8 2730.2 2799.2 2809.0 2820.0 2923.8 451760.0 476238.0 487119.0 490026.0 490900.5 50226.5 63243.7 63363.4 68768.0 72533.6 71372.3 71402.6 71560.3 71568.0 71707.3 16773.2 17144.0 17164.7 17178.9 17186.9 11806.5 11995.7 12235.0 12902.2 12955.7 22003.4 22595.8 22611.5 22616.7 22630.5 9459.2 9726.2 9762.4 9763.7 9778.5 943.7 957.2 990.2 1027.9 1030.4 30311.7 30468.0 30668.7 31195.7 31350.0 1077.2 1077.4 1112.3 1126.7 1141.1 14374.7 14532.8 14557.0 14836.5 14863.2 548712.0 548889.0 549804.0 550404.0 551756.2 60092.7 60390.4 60485.0 60488.4 60552.7 1264.0 1476.2 1495.3 1496.4 1501.5 28937.6 29321.9 30744.7 30770.8 31504.4 53067.2 53346.5 53483.5 53515.0 53610.7 455083.0 457085.0 457325.0 459042.0 459747.0 27736.6 32360.6 33274.3 33571.0 33591.8 45209.3 45828.0 46060.3 46299.8 46979.3 38215.8 38359.4 39064.0 39136.0 39318.6 29743.7 37811.9 38065.6 38490.6 38676.8 34386.8 35183.2 35939.8 36532.3 36717.6 31754.5 34061.1 34492.7 34501.8 34589.1 25456.7 25678.6 25716.0 25738.7 26287.2 19:52:56 INFO - 2015-11-20 19:52:56,554 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,554 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39258.44 Median:25581.18 stddev:125198.46 (489.4%) stddev-sans-first:125515.59 19:52:56 INFO - 2015-11-20 19:52:56,556 DEBUG : BROWSER_OUTPUT: Values: 353.3 355.3 355.4 357.3 360.2 15716.9 15888.8 19630.5 20574.8 21347.5 16656.8 20116.6 20490.5 20587.9 20592.8 5419.5 5768.9 5768.9 5770.3 5770.7 3038.9 4174.9 4303.3 5798.8 5813.7 5133.7 6213.8 6219.4 6219.9 6226.2 6080.8 6141.1 6207.1 6238.9 6240.2 5341.4 5346.5 5348.9 5350.9 5354.0 25365.7 25796.6 25894.4 25990.5 26137.2 2066.2 2153.6 2169.6 2336.2 2350.0 14559.6 14590.2 14774.5 15153.9 15322.6 1708.5 1744.2 1754.9 1785.8 1789.5 93986.1 97538.5 97829.0 98683.0 99401.0 9883.4 10091.4 10281.0 10291.0 10296.0 12504.4 12524.6 12527.4 12527.9 12537.8 8509.6 8520.6 8526.1 8571.3 8590.3 7194.4 8852.2 8887.6 8957.4 8981.0 6124.5 6133.2 6142.4 6154.9 6164.4 1551.5 1621.6 1703.5 1715.0 1751.9 816.6 951.9 1033.6 1036.2 1064.6 11642.3 11900.8 11911.8 20724.7 21163.3 426.5 430.8 433.8 438.4 447.9 5959.7 6115.1 6181.6 6191.1 6194.6 756147.0 756424.0 758006.2 762164.0 770383.0 84552.0 128566.0 131427.0 131469.7 133946.0 383.4 405.6 490.0 490.6 491.4 11150.3 18875.1 20032.9 20229.9 20365.4 56587.0 57399.0 57410.0 57882.4 57889.4 73502.6 73545.9 73972.0 74887.9 77949.6 10038.7 10050.2 10275.1 10287.5 10365.2 20386.9 20441.9 20640.6 21110.0 21190.0 11388.8 14146.4 16169.4 16328.3 16742.6 15380.4 15423.5 15809.3 16162.6 16433.8 13042.0 13136.5 16264.4 16288.4 16805.6 9819.5 10010.0 10038.7 10054.8 10062.7 10389.6 11613.8 14087.2 16079.3 16289.8 19:52:56 INFO - 2015-11-20 19:52:56,556 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,556 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5883.01 Median:5238.48 stddev:3103.97 (59.3%) stddev-sans-first:3095.68 19:52:56 INFO - 2015-11-20 19:52:56,557 DEBUG : BROWSER_OUTPUT: Values: 1561.2 1723.6 1771.9 1986.2 2042.6 7574.1 7980.3 8233.6 8314.3 8360.1 8408.1 8526.6 8550.5 8570.9 8571.4 2090.5 2182.4 2382.5 2403.2 2408.3 2198.4 2382.4 2414.2 2415.2 2417.5 2331.4 2366.3 2366.9 2375.8 2385.7 2132.1 2195.2 2348.2 2378.7 2408.1 2368.8 2374.5 2376.7 2378.5 2379.7 8428.9 8581.8 8592.8 8596.3 8608.5 5144.4 5233.8 5250.4 5253.4 5269.2 3506.9 3523.1 3602.4 3606.5 3626.3 1024.6 1027.0 1054.6 1060.5 1062.2 11366.8 11382.6 11385.4 11388.6 11424.5 4674.8 4720.7 4739.6 4743.5 4786.5 9665.0 9770.8 9786.0 9795.2 9807.6 5188.8 5215.6 5226.9 5243.2 5248.3 4785.5 4828.7 4842.3 4842.8 4843.3 3453.8 3667.0 3842.8 3892.4 3929.2 1282.1 1285.3 1293.5 1297.9 1317.1 1062.5 1085.6 1085.7 1269.2 1418.1 7852.1 7908.4 7963.5 7987.3 8006.6 496.6 507.7 512.9 515.3 516.0 5097.0 5846.1 5985.0 6002.2 6363.8 10108.4 10206.5 10297.1 10357.6 10412.5 10254.7 10264.1 10264.2 10268.7 10273.9 7863.2 8000.8 8015.0 8104.0 8114.6 7798.0 7861.0 7887.6 7893.2 7909.0 9055.0 9088.0 9117.5 9162.2 9233.5 9317.6 9460.2 9599.5 9606.9 9607.4 7231.6 7269.1 7293.6 7294.3 7304.9 7979.6 8036.8 8075.0 8094.4 8121.3 7521.8 7543.7 7623.3 7647.3 7700.2 6325.9 7438.1 7509.6 7539.7 7572.6 7439.7 7554.1 7601.6 7616.0 7720.7 6981.5 7026.6 7029.8 7031.8 7036.2 6381.5 6436.1 7120.2 7151.6 7155.1 19:52:56 INFO - 2015-11-20 19:52:56,557 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,557 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5856.47 Median:6699.60 stddev:1896.20 (28.3%) stddev-sans-first:1855.37 19:52:56 INFO - 2015-11-20 19:52:56,559 DEBUG : BROWSER_OUTPUT: Values: 316.5 321.3 327.5 331.2 336.3 6592.2 6708.1 6709.7 6736.8 6754.7 6578.3 6691.1 6741.0 6762.5 6809.4 4987.8 5034.2 5038.2 5038.8 5052.3 4705.2 4760.9 4892.8 5022.6 5039.3 3974.4 4929.5 4951.6 4970.2 4974.9 4008.6 5010.8 5010.9 5017.8 5018.4 4262.8 4263.3 4269.9 4270.6 4272.6 6247.8 6446.7 6449.5 6487.2 6517.5 4936.0 5839.0 5907.4 5926.9 5948.1 5745.2 7197.6 7261.1 7271.1 7271.7 4516.0 4674.7 4679.2 4781.6 4797.8 6217.5 7668.8 7747.9 7762.8 7766.7 3886.7 4503.6 4730.7 4733.8 4736.6 3805.7 4673.9 4673.9 4676.7 4696.3 5551.0 5657.0 5768.0 5816.1 5816.4 6207.8 7341.1 7351.4 7352.7 7371.6 1599.4 1657.6 1674.2 1674.9 1678.3 877.0 1060.5 1062.9 1066.8 1067.3 6710.6 6744.1 6747.2 6754.0 6774.0 7575.8 7577.0 7580.4 7581.4 7582.6 6466.5 6710.9 6736.8 6754.4 6758.1 3990.3 4035.2 4037.3 4041.6 4042.3 7610.7 7613.7 7623.0 7623.8 7632.0 6349.9 7542.2 7843.3 7853.8 7854.1 7582.4 7585.9 7588.6 7597.7 7599.0 6560.3 7432.6 7535.1 7554.0 7564.2 5979.5 7150.7 7454.9 7461.0 7461.3 7598.8 7600.7 7603.2 7603.8 7620.7 4545.9 4632.4 4645.0 4653.9 4749.5 6535.8 7067.7 7536.0 7585.1 7587.0 7256.0 7256.4 7273.2 7303.2 7306.3 7065.4 7233.5 7242.4 7254.0 7313.4 7142.1 7151.4 7164.7 7168.5 7170.4 7176.9 7313.7 7323.2 7361.4 7370.9 5772.9 7183.4 7186.5 7211.2 7214.1 19:52:56 INFO - 2015-11-20 19:52:56,559 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,559 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18396.94 Median:615.81 stddev:26053.86 (4230.9%) stddev-sans-first:26093.20 19:52:56 INFO - 2015-11-20 19:52:56,560 DEBUG : BROWSER_OUTPUT: Values: 736.2 773.6 776.0 812.4 835.2 14946.6 15448.9 15478.6 15481.1 15485.1 14182.8 14270.3 14286.9 14289.5 14320.5 749.3 764.1 765.6 768.5 947.2 948.3 951.6 967.6 968.7 969.4 1008.8 1019.6 1022.3 1023.4 1024.6 797.5 810.8 811.6 992.7 1004.6 753.9 757.8 759.3 760.2 762.1 14840.5 15000.4 15007.1 15018.2 15032.2 12330.6 12791.1 12807.2 12941.0 12967.4 8369.0 8403.3 10086.8 10177.2 10233.6 3563.4 3635.4 3645.3 3658.2 3792.5 77183.8 78019.0 79840.0 79912.0 80062.2 9596.3 9636.5 9674.1 9797.4 9924.3 22066.7 22067.0 22074.9 22081.0 22120.4 7434.3 7565.8 7636.1 7816.0 7826.3 3484.7 4019.0 4098.6 4103.4 4112.1 3471.6 3512.2 3515.5 3521.2 3525.2 613.5 629.7 631.2 647.8 649.6 534.8 573.5 578.4 609.1 618.2 9012.2 9057.6 9228.7 9316.0 9394.4 502.8 522.8 601.7 618.2 620.5 3920.5 4007.5 4011.1 4125.9 4151.4 92257.0 93721.5 93767.0 94039.0 94518.5 65145.0 69582.0 80936.2 84036.6 85162.0 72143.6 72244.0 73208.0 73268.0 73711.0 8096.4 8124.5 8225.2 8260.8 8417.4 41180.8 48581.0 50110.0 51361.7 51643.0 67989.6 72856.6 73132.6 73257.0 74858.6 8904.6 9712.5 10081.0 10396.3 10538.4 9906.9 11049.0 11069.5 12113.9 12156.9 9928.8 10308.6 10395.4 10609.4 10766.6 9989.4 10570.6 10589.8 11066.5 11249.2 10969.7 11029.4 11241.8 11478.1 12119.6 7697.0 9677.5 9748.4 9997.5 10107.6 8652.9 9838.9 10036.4 10037.2 10171.6 19:52:56 INFO - 2015-11-20 19:52:56,560 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:52:56 INFO - 2015-11-20 19:52:56,560 DEBUG : BROWSER_OUTPUT: 19:52:56 INFO - 2015-11-20 19:52:56,957 INFO : Browser exited with error code: 0 19:52:56 INFO - 2015-11-20 19:52:56,981 INFO : Completed test dromaeo_css (00:18:34) 19:52:56 INFO - 2015-11-20 19:52:56,981 INFO : Starting test kraken 19:52:56 INFO - 2015-11-20 19:52:56,981 DEBUG : operating with platform_type : mac_ 19:52:56 INFO - 2015-11-20 19:52:56,981 INFO : Initialising browser for kraken test... 19:52:56 INFO - 2015-11-20 19:52:56,994 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp_PDOPm/profile http://localhost:49274/getInfo.html 19:52:58 INFO - 2015-11-20 19:52:58,828 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:52:58 INFO - 2015-11-20 19:52:58,829 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:52:58 INFO - 2015-11-20 19:52:58,829 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:52:58 INFO - 2015-11-20 19:52:58,829 DEBUG : BROWSER_OUTPUT: __metrics 19:52:58 INFO - 2015-11-20 19:52:58,844 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:59 INFO - 2015-11-20 19:52:59,482 INFO : Browser initialized. 19:52:59 INFO - 2015-11-20 19:52:59,482 INFO : Running cycle 1/1 for kraken test... 19:52:59 INFO - 2015-11-20 19:52:59,483 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp_PDOPm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:53:11 INFO - 2015-11-20 19:53:11,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 226447360 19:53:11 INFO - 2015-11-20 19:53:11,406 DEBUG : BROWSER_OUTPUT: 19:53:13 INFO - 2015-11-20 19:53:13,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 19:53:14 INFO - 2015-11-20 19:53:14,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 276033536 19:53:14 INFO - 2015-11-20 19:53:14,527 DEBUG : BROWSER_OUTPUT: 19:53:17 INFO - 2015-11-20 19:53:17,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 19:53:17 INFO - 2015-11-20 19:53:17,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 290357248 19:53:17 INFO - 2015-11-20 19:53:17,871 DEBUG : BROWSER_OUTPUT: 19:53:21 INFO - 2015-11-20 19:53:21,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 19:53:21 INFO - 2015-11-20 19:53:21,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 276074496 19:53:21 INFO - 2015-11-20 19:53:21,898 DEBUG : BROWSER_OUTPUT: 19:53:23 INFO - 2015-11-20 19:53:23,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 19:53:24 INFO - 2015-11-20 19:53:24,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 278470656 19:53:24 INFO - 2015-11-20 19:53:24,339 DEBUG : BROWSER_OUTPUT: 19:53:26 INFO - 2015-11-20 19:53:26,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:53:27 INFO - 2015-11-20 19:53:27,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 280494080 19:53:27 INFO - 2015-11-20 19:53:27,002 DEBUG : BROWSER_OUTPUT: 19:53:29 INFO - 2015-11-20 19:53:29,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 19:53:30 INFO - 2015-11-20 19:53:30,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 281047040 19:53:30 INFO - 2015-11-20 19:53:30,441 DEBUG : BROWSER_OUTPUT: 19:53:33 INFO - 2015-11-20 19:53:33,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:33 INFO - 2015-11-20 19:53:33,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 280731648 19:53:33 INFO - 2015-11-20 19:53:33,812 DEBUG : BROWSER_OUTPUT: 19:53:36 INFO - 2015-11-20 19:53:36,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 19:53:37 INFO - 2015-11-20 19:53:37,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 280924160 19:53:37 INFO - 2015-11-20 19:53:37,238 DEBUG : BROWSER_OUTPUT: 19:53:38 INFO - 2015-11-20 19:53:38,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:39 INFO - 2015-11-20 19:53:39,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 316137472 19:53:39 INFO - 2015-11-20 19:53:39,335 DEBUG : BROWSER_OUTPUT: 19:53:41 INFO - 2015-11-20 19:53:41,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:41 INFO - 2015-11-20 19:53:41,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 316919808 19:53:41 INFO - 2015-11-20 19:53:41,752 DEBUG : BROWSER_OUTPUT: 19:53:43 INFO - 2015-11-20 19:53:43,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:44 INFO - 2015-11-20 19:53:44,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 323006464 19:53:44 INFO - 2015-11-20 19:53:44,373 DEBUG : BROWSER_OUTPUT: 19:53:46 INFO - 2015-11-20 19:53:46,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:47 INFO - 2015-11-20 19:53:47,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 325611520 19:53:47 INFO - 2015-11-20 19:53:47,490 DEBUG : BROWSER_OUTPUT: 19:53:49 INFO - 2015-11-20 19:53:49,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:50 INFO - 2015-11-20 19:53:50,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 324722688 19:53:50 INFO - 2015-11-20 19:53:50,473 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 19:53:52 INFO - 2015-11-20 19:53:52,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 383524864 19:53:52 INFO - 2015-11-20 19:53:52,372 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,372 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:53:52 INFO - 2015-11-20 19:53:52,372 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;106;111;110;112;99;111;112;110 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;149;183;164;116;139;165;149;150;120 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |2;audio-dft;198;258;192;179;187;182;186;182;194;260 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;64;74;73;54;57;57;73;74;54 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;86;114;75;75;74;111;75;100;144 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;88;88;88;89;88;102;134;114;88 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;95;95;95;99;95;96;95;95;95 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;96;141;85;97;127;85;84;85;85 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;55;55;55;53;54;55;64;52;55 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;67;64;65;67;67;67;68;68 19:53:52 INFO - 2015-11-20 19:53:52,373 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;80;81;81;79;82;82;82;83 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;126;129;115;124;126;122;120;118;122 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;123;134;132;130;123;137;135;134;132 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;64;65;66;64;63;64;62;62 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1054 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078032369__endTimestamp 19:53:52 INFO - 2015-11-20 19:53:52,374 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 106.0 111.0 110.0 112.0 99.0 111.0 112.0 110.0 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:151.50 stddev:20.23 (13.4%) stddev-sans-first:21.40 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: Values: 153.0 149.0 183.0 164.0 116.0 139.0 165.0 149.0 150.0 120.0 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,378 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.80 Median:193.00 stddev:30.71 (15.9%) stddev-sans-first:32.55 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: Values: 198.0 258.0 192.0 179.0 187.0 182.0 186.0 182.0 194.0 260.0 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.70 Median:70.00 stddev:8.59 (12.3%) stddev-sans-first:9.07 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: Values: 67.0 64.0 74.0 73.0 54.0 57.0 57.0 73.0 74.0 54.0 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:93.60 Median:75.00 stddev:23.37 (31.2%) stddev-sans-first:24.41 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: Values: 82.0 86.0 114.0 75.0 75.0 74.0 111.0 75.0 100.0 144.0 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,379 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:88.00 stddev:15.69 (17.8%) stddev-sans-first:16.39 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 88.0 88.0 89.0 88.0 102.0 134.0 114.0 88.0 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 99.0 95.0 96.0 95.0 95.0 95.0 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:85.00 stddev:20.35 (23.9%) stddev-sans-first:21.11 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: Values: 85.0 96.0 141.0 85.0 97.0 127.0 85.0 84.0 85.0 85.0 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.34 (6.1%) stddev-sans-first:3.43 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: Values: 58.0 55.0 55.0 55.0 53.0 54.0 55.0 64.0 52.0 55.0 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,380 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 67.0 64.0 65.0 67.0 67.0 67.0 68.0 68.0 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 80.0 81.0 81.0 79.0 82.0 82.0 82.0 83.0 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:125.00 stddev:4.61 (3.7%) stddev-sans-first:4.36 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: Values: 129.0 126.0 129.0 115.0 124.0 126.0 122.0 120.0 118.0 122.0 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.90 Median:134.00 stddev:5.34 (4.0%) stddev-sans-first:5.01 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: Values: 139.0 123.0 134.0 132.0 130.0 123.0 137.0 135.0 134.0 132.0 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.33 (2.1%) stddev-sans-first:1.36 19:53:52 INFO - 2015-11-20 19:53:52,381 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 64.0 65.0 66.0 64.0 63.0 64.0 62.0 62.0 19:53:52 INFO - 2015-11-20 19:53:52,382 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:53:52 INFO - 2015-11-20 19:53:52,382 DEBUG : BROWSER_OUTPUT: 19:53:53 INFO - 2015-11-20 19:53:53,106 INFO : Browser exited with error code: 0 19:53:53 INFO - 2015-11-20 19:53:53,151 INFO : Completed test kraken (00:00:56) 19:53:53 INFO - 2015-11-20 19:53:53,151 INFO : Starting test v8_7 19:53:53 INFO - 2015-11-20 19:53:53,151 DEBUG : operating with platform_type : mac_ 19:53:53 INFO - 2015-11-20 19:53:53,151 INFO : Initialising browser for v8_7 test... 19:53:53 INFO - 2015-11-20 19:53:53,164 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpI6XnlP/profile http://localhost:49274/getInfo.html 19:53:55 INFO - 2015-11-20 19:53:55,117 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:53:55 INFO - 2015-11-20 19:53:55,117 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:53:55 INFO - 2015-11-20 19:53:55,117 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:53:55 INFO - 2015-11-20 19:53:55,117 DEBUG : BROWSER_OUTPUT: __metrics 19:53:55 INFO - 2015-11-20 19:53:55,134 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:53:55 INFO - 2015-11-20 19:53:55,862 INFO : Browser initialized. 19:53:55 INFO - 2015-11-20 19:53:55,863 INFO : Running cycle 1/1 for v8_7 test... 19:53:55 INFO - 2015-11-20 19:53:55,863 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpI6XnlP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:54:07 INFO - 2015-11-20 19:54:07,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 226152448 19:54:07 INFO - 2015-11-20 19:54:07,851 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 19:54:29 INFO - 2015-11-20 19:54:29,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 648949760 19:54:29 INFO - 2015-11-20 19:54:29,610 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:54:29 INFO - 2015-11-20 19:54:29,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:54:29 INFO - 2015-11-20 19:54:29,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:54:29 INFO - 2015-11-20 19:54:29,611 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |0;Richards;148.41199168892845 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.77170418006432 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4780.952380952381 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1712.3287671232877 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |6;Boyer;13333.333333333334 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |7;RegExp;28857.14285714286 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |8;Splay;748.502994011976 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:54:29 INFO - 2015-11-20 19:54:29,612 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078069609__endTimestamp 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.41 Median:148.41 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: Values: 148.4 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.77 Median:160.77 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: Values: 160.8 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: Values: 281.3 19:54:29 INFO - 2015-11-20 19:54:29,613 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4780.95 Median:4780.95 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: Values: 4781.0 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1712.33 Median:1712.33 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: Values: 1712.3 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: Values: 794.3 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13333.33 Median:13333.33 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,614 DEBUG : BROWSER_OUTPUT: Values: 13333.3 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28857.14 Median:28857.14 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: Values: 28857.1 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:748.50 Median:748.50 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: Values: 748.5 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: Values: 4533.9 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:54:29 INFO - 2015-11-20 19:54:29,615 DEBUG : BROWSER_OUTPUT: 19:54:30 INFO - 2015-11-20 19:54:30,264 INFO : Browser exited with error code: 0 19:54:30 INFO - 2015-11-20 19:54:30,282 INFO : Completed test v8_7 (00:00:37) 19:54:30 INFO - 2015-11-20 19:54:30,611 INFO : Completed test suite (00:20:07) 19:54:30 INFO - 2015-11-20 19:54:30,611 DEBUG : Working with test: dromaeo_css 19:54:30 INFO - 2015-11-20 19:54:30,611 DEBUG : Generating results file: dromaeo_css 19:54:30 INFO - 2015-11-20 19:54:30,612 DEBUG : Working with test: kraken 19:54:30 INFO - 2015-11-20 19:54:30,612 DEBUG : Generating results file: kraken 19:54:30 INFO - 2015-11-20 19:54:30,612 INFO : javascript benchmark 19:54:30 INFO - 2015-11-20 19:54:30,612 DEBUG : Working with test: v8_7 19:54:30 INFO - 2015-11-20 19:54:30,612 DEBUG : Generating results file: v8_7 19:54:30 INFO - 2015-11-20 19:54:30,613 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:30 INFO - 2015-11-20 19:54:30,660 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:54:30 INFO - 2015-11-20 19:54:30,660 DEBUG : process_Request line: dromaeo_css 7589.86 graph.html#tests=[[72,64,59]] 19:54:30 INFO - 2015-11-20 19:54:30,660 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:30 INFO - 2015-11-20 19:54:30,686 DEBUG : process_Request line: kraken 1429.40 graph.html#tests=[[232,64,59]] 19:54:30 INFO - 2015-11-20 19:54:30,686 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:54:30 INFO - 2015-11-20 19:54:30,709 DEBUG : process_Request line: v8_7 20137.46 graph.html#tests=[[230,64,59]] 19:54:30 INFO - 2015-11-20 19:54:30,710 INFO : javascript benchmark 19:54:30 INFO - 2015-11-20 19:54:30,712 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3435.70796482299, 3525.82370881456, 3536.9646303536956, 3553.3426316131536, 3582.319359321729, 4410.360497727827, 5479.205515200293, 5747.885042299152, 5865.296164460271, 6045.304789949158, 5963.612365196259, 5995.550333724967, 6031.638101713889, 6158.107074474198, 6170.876582468359, 5318.973405132969, 5357.892842143155, 5358.4641535846295, 5370.355557333126, 5439.755211015494, 5481.972590137064, 5485.451454854522, 5511.173324001412, 5526.336839579256, 5550.750216240259, 5206.843794686184, 5321.494458026481, 5330.253764472977, 5335.413104558495, 5413.0, 5261.4738526147075, 5332.813351532678, 5371.785128594852, 5376.78492860289, 5384.838454846361, 5338.492843179892, 5364.141737322048, 5366.141417373241, 5373.650712703662, 5378.193271009341, 5759.107338362561, 5941.405859414067, 5947.316058653267, 5965.105234214859, 5980.940190598082, 6244.87510249797, 6264.906026409608, 6268.059791031336, 6395.42441180296, 6414.871702565969, 6439.742410303582, 6450.903236451457, 6461.483081353527, 6484.967575162094, 6491.091247225392, 5897.587168898136, 6064.36324185963, 6133.355997620275, 6136.938630613681, 6140.6929653517145, 6339.619622822645, 6436.645984470899, 6495.805125846232, 6497.642629655415, 6511.804645860631, 6053.697315134225, 6174.969125154345, 6176.166217560572, 6185.288691800501, 6189.535784816157, 6394.488440924715, 6416.454601358937, 6426.710798014101, 6430.131932189188, 6438.452731517874, 6138.199401565478, 6249.906266403361, 6280.214973128359, 6368.4586810121655, 6370.58591191571, 6159.168512250879, 6206.441420272107, 6243.8126856194385, 6325.0, 6352.364763523703, 5118.59051275897, 5125.1287281162295, 5132.666376685504, 5134.948650513522, 5166.276721259027, 4286.292761694348, 4554.521775213555, 4609.8156073757345, 4617.676762626584, 4651.976740116278, 5947.851303717355, 5953.315368732651, 6004.099385092184, 6062.514054418727, 6122.112293717386, 5565.443455654483, 6221.724546467964, 6427.485801135991, 6431.163948686641, 6439.291677915426, 5759.913601295984, 6039.577229593974, 6041.8489537761025, 6052.576319657582, 6057.091436284592, 5483.424240454775, 5540.36285827127, 5565.554755619541, 5570.3315602128005, 5589.077802162679, 6256.718447669957, 6300.684965751786, 6325.272593651697, 6340.1123842661145, 6346.650934198663, 5374.946250537445, 6423.100765892686, 6428.582142160744, 6440.066190402459, 6442.935570644421, 6400.871982560416, 6418.871622567429, 6420.357964203542, 6428.453581445629, 6447.065175549613, 5555.3611334697025, 6047.911375952371, 6216.689165541795, 6306.621602703853, 6325.936740632719, 6383.0744542042075, 6392.776252831129, 6405.519586030973, 6408.967955160194, 6410.1025856381075, 5451.373092094302, 5630.071038278638, 6343.841403964938, 6354.7140378684, 6363.6818159090935, 6114.938850611615, 6142.989934931762, 6202.038684003986, 6220.533459990428, 6329.556931014785, 6159.476444502088, 6226.750929962932, 6227.06594010902, 6233.657148856856, 6248.750049998131, 5501.752421140978, 6131.662758548323, 6324.905126423016, 6336.081268216175, 6349.428551430394, 5133.8716532087, 5956.791512297049, 6077.6961151943115, 6089.299730530868, 6260.436560709558], "unit": "ms", "name": "dojo.html", "value": 5833.135006903557}, {"lowerIsBetter": false, "replicates": [552.464109813481, 573.9081746920493, 587.166223961974, 612.9478994285486, 638.0206383201786, 32324.838375808118, 32834.34331313372, 42420.0, 42733.57266427335, 42735.57264427355, 45708.54291457085, 45951.080978380494, 45951.77024114883, 45954.31068533975, 45959.0, 9798.951005244964, 10011.449370284632, 10013.449260290681, 10023.148032417253, 10059.748506287366, 8272.379571532128, 9901.603935842557, 9911.405315681046, 9913.702588922344, 9918.0, 9858.0, 9922.652707155252, 9932.95033524835, 9933.652322168726, 9936.701898943043, 9844.458554779485, 9933.403995760205, 9935.10584047432, 9939.304248702594, 9942.30403871722, 9789.657361992297, 9891.604335826558, 9896.752581185456, 9900.851487227625, 9903.702888913343, 42147.367789483185, 42547.361789572875, 42620.57379426228, 42645.0, 42647.720568382996, 2859.6711378191358, 3224.274538228903, 3254.479283314682, 3296.2089098616398, 3353.9099792567267, 29245.68394422235, 29608.851955740298, 29961.850190749126, 30146.397072058437, 30206.84896575525, 2730.180945716297, 2799.1882354117283, 2808.985955070232, 2819.9989003903524, 2923.780716446275, 451760.0, 476238.0, 487119.0, 490026.0, 490900.5454972738, 50226.49773502292, 63243.68378158172, 63363.366366335744, 68767.96848047283, 72533.637331813, 71372.28627713761, 71402.64298678577, 71560.28439715537, 71568.0, 71707.28292717111, 16773.24520396585, 17144.0, 17164.742528862076, 17178.914105429394, 17186.91406542959, 11806.46870890812, 11995.700107497209, 12235.0, 12902.161359511601, 12955.740885182244, 22003.449913752283, 22595.774042259694, 22611.547769044526, 22616.660750088762, 22630.547389052128, 9459.195968342769, 9726.173275271682, 9762.414255144715, 9763.658271960589, 9778.511074446249, 943.6508491858057, 957.1863915671762, 990.2424645146468, 1027.9280450368403, 1030.4332617060586, 30311.696883030887, 30468.0, 30668.69331306703, 31195.688043119277, 31350.0, 1077.21363404715, 1077.3912739302425, 1112.3048094940661, 1126.723952631594, 1141.1213365708359, 14374.712505750036, 14532.782008269884, 14557.0, 14836.480723174636, 14863.18252496123, 548712.0, 548889.0, 549804.0, 550404.0, 551756.1709723072, 60092.69953650204, 60390.39609603935, 60485.0, 60488.395116049156, 60552.69723651354, 1263.9936800316123, 1476.2028504607392, 1495.2673190136973, 1496.4313560847027, 1501.5420296809577, 28937.56593651139, 29321.85339073291, 30744.692553074183, 30770.846145769126, 31504.36991260116, 53067.20399194092, 53346.46653533415, 53483.46516534785, 53515.0, 53610.65973350542, 455083.0, 457085.0, 457325.0, 459042.0, 459747.0, 27736.58395124115, 32360.6021367753, 33274.33451331008, 33571.0, 33591.832040840614, 45209.32186017147, 45828.0, 46060.30909536293, 46299.768501157276, 46979.295310571055, 38215.80892095522, 38359.42460863145, 39064.0, 39136.0, 39318.60681393264, 29743.702562974093, 37811.865644030724, 38065.61934380732, 38490.615093849825, 38676.80661596674, 34386.82806585951, 35183.19394663399, 35939.820300898326, 36532.269354612225, 36717.63282367249, 31754.523682144325, 34061.14847128842, 34492.65507344894, 34501.82749086339, 34589.13527161841, 25456.745432546177, 25678.614820778075, 25716.0, 25738.742612574384, 26287.21138365852], "unit": "ms", "name": "ext.html", "value": 20356.067897533158}, {"lowerIsBetter": false, "replicates": [353.3427824246902, 355.26814761591123, 355.3745408081775, 357.3478401916502, 360.2003552114305, 15716.921415392908, 15888.841111588881, 19630.509237269056, 20574.794252057476, 21347.466313342175, 16656.75014874775, 20116.59766804663, 20490.487737806525, 20587.897060514675, 20592.79407205931, 5419.458054194579, 5768.913466297988, 5768.942310576904, 5770.307563092414, 5770.653760774346, 3038.9392212155744, 4174.874753757377, 4303.332983387564, 5798.797042103527, 5813.709314534278, 5133.691978481284, 6213.751449941997, 6219.378062193767, 6219.906701399483, 6226.190595222637, 6080.787172448965, 6141.078838174287, 6207.068939659065, 6238.875222495525, 6240.157578726859, 5341.385740639837, 5346.465353464661, 5348.946510534884, 5350.866228344284, 5353.973230133864, 25365.746342536524, 25796.61305080425, 25894.352641183934, 25990.480190396087, 26137.215883523524, 2066.245820275604, 2153.5800518898823, 2169.642009068502, 2336.2290444153386, 2350.048230466664, 14559.636009099751, 14590.197539135343, 14774.48289309869, 15153.939224254307, 15322.616934576614, 1708.5386945524763, 1744.2325376834153, 1754.9034803085826, 1785.7857057153094, 1789.4899953513186, 93986.06013939841, 97538.51230743872, 97829.0, 98683.0, 99401.0, 9883.369244074791, 10091.394516329045, 10281.0, 10291.0, 10296.0, 12504.437300321508, 12524.624261271994, 12527.43626536808, 12527.874721252852, 12537.811932821014, 8509.574521273911, 8520.616572254263, 8526.147385261424, 8571.271441927505, 8590.312774977987, 7194.424446044304, 8852.247558957431, 8887.644494220158, 8957.417767845069, 8980.955095224483, 6124.540659450559, 6133.233345831771, 6142.416470435302, 6154.876902461926, 6164.4143806338325, 1551.5422950229708, 1621.6189195539039, 1703.5485596316985, 1715.0, 1751.8948863068256, 816.6406781016452, 951.8714973478492, 1033.6227277043824, 1036.1917704190744, 1064.5582083435443, 11642.301461912313, 11900.761984760256, 11911.76176476483, 20724.689129663067, 21163.25928592492, 426.54572879883443, 430.77814925313487, 433.8438162261583, 438.44098774063326, 447.86564030790635, 5959.748090047322, 6115.143879856823, 6181.567290289637, 6191.133241346215, 6194.566380353332, 756147.0, 756424.0, 758006.2099689466, 762164.0, 770383.0, 84552.0, 128566.00455617139, 131427.0, 131469.68530314765, 133946.0, 383.38083994348926, 405.61669222584965, 490.0493043495607, 490.5805536266441, 491.40785353648766, 11150.275232109887, 18875.056247187862, 20032.899835500728, 20229.88735619555, 20365.389038328874, 56587.0, 57399.0, 57410.0, 57882.421175787706, 57889.42110579009, 73502.63248683722, 73545.8968115468, 73972.0, 74887.8766818509, 77949.61025194838, 10038.698839034842, 10050.195984321383, 10275.075243228146, 10287.53706083213, 10365.222608304559, 20386.898065509577, 20441.897790510953, 20640.58718825645, 21110.0, 21190.0, 11388.772224555296, 14146.363413646204, 16169.434069807501, 16328.346866125697, 16742.58143546421, 15380.38478460849, 15423.537293881202, 15809.288582013607, 16162.595935101717, 16433.835661643232, 13042.0, 13136.474541018635, 16264.430744923871, 16288.429904953744, 16805.579860503585, 9819.509024548886, 10010.0, 10038.749031274276, 10054.798904021733, 10062.69811905644, 10389.636362727268, 11613.825792613286, 14087.15477071338, 16079.27643256033, 16289.837101628833], "unit": "ms", "name": "jquery.html", "value": 9453.132962535175}, {"lowerIsBetter": false, "replicates": [1561.2193903048474, 1723.6121872578678, 1771.902545360005, 1986.1856638778104, 2042.5506388594504, 7574.091109066912, 7980.321672657824, 8233.629486673099, 8314.334853211743, 8360.080391156984, 8408.117147699495, 8526.616302266397, 8550.486970781758, 8570.914290857105, 8571.442856214357, 2090.456481314854, 2182.4216582605623, 2382.4520360317138, 2403.170906037423, 2408.2654790288957, 2198.362474882282, 2382.4282172278613, 2414.1550457339968, 2415.2271273192587, 2417.504411595619, 2331.440454290975, 2366.2664573982033, 2366.8698221597892, 2375.7861792438675, 2385.689860318156, 2132.0618927671853, 2195.1768086967386, 2348.248560460653, 2378.6788783514176, 2408.1330720940446, 2368.7749663781915, 2374.536965291769, 2376.6791483149727, 2378.4886249456276, 2379.654950032253, 8428.915710842874, 8581.828363432758, 8592.828143437158, 8596.269317108054, 8608.52653104079, 5144.356955380577, 5233.764480598382, 5250.369955605352, 5253.448387919251, 5269.1832765921345, 3506.8597256109724, 3523.066387407339, 3602.351576716216, 3606.495090687306, 3626.256617393428, 1024.5748014573942, 1026.9537870795832, 1054.6361505280743, 1060.496264274471, 1062.2245760594733, 11366.829497557543, 11382.60160894373, 11385.430728463543, 11388.60139895108, 11424.485898134604, 4674.795753033733, 4720.669553131248, 4739.644526660514, 4743.454502732161, 4786.497417771154, 9664.951675241578, 9770.804583908424, 9786.0, 9795.167410770022, 9807.558659860324, 5188.766505507261, 5215.556677682363, 5226.895462090737, 5243.1873059675045, 5248.343957005374, 4785.545373189541, 4828.686135401258, 4842.322074909445, 4842.782074806642, 4843.346148269939, 3453.792772433662, 3667.0, 3842.7502212356108, 3892.3966785148345, 3929.1945151243926, 1282.1089342906591, 1285.2609749394135, 1293.502001729341, 1297.935103244834, 1317.0583033131356, 1062.4740753327153, 1085.582050910405, 1085.7394225385851, 1269.225772278909, 1418.14202407544, 7852.057753069668, 7908.406869484812, 7963.482373645695, 7987.281144697005, 8006.599670016476, 496.63993604637074, 507.66747780204025, 512.9102407078747, 515.2786099460785, 516.0298638559484, 5096.974515127475, 5846.093855452412, 5985.042393217152, 6002.159697642333, 6363.809085727436, 10108.39349639024, 10206.489675516195, 10297.12474439681, 10357.585696572203, 10412.479376031168, 10254.743631409274, 10264.127549158256, 10264.230182736324, 10268.691939241835, 10273.9486302568, 7863.174366691415, 8000.839983200303, 8014.959925200336, 8104.0, 8114.634841432032, 7798.0, 7861.0, 7887.566183859943, 7893.210678932061, 7908.960455197687, 9054.954725226331, 9087.954560227157, 9117.5441227937, 9162.221211197122, 9233.49215793111, 9317.627294908129, 9460.243180545402, 9599.47202903847, 9606.855897161407, 9607.423554586747, 7231.63841807918, 7269.091363579552, 7293.562386256842, 7294.307040831112, 7304.853902922018, 7979.640916158903, 8036.799080023046, 8074.959625201836, 8094.3929205311015, 8121.309688676292, 7521.849563008818, 7543.660535275816, 7623.313901748869, 7647.311741943252, 7700.229977002255, 6325.8734825304155, 7438.107427108782, 7509.6245187739305, 7539.660715267716, 7572.621368931421, 7439.702411903463, 7554.131274903457, 7601.619919004138, 7616.0, 7720.652570634447, 6981.476389270927, 7026.578405295699, 7029.824254393681, 7031.824204394931, 7036.19083805369, 6381.521385895983, 6436.098946147449, 7120.2167761547225, 7151.642417878981, 7155.069840920647], "unit": "ms", "name": "mootools.html", "value": 4720.213849205024}, {"lowerIsBetter": false, "replicates": [316.4841308666873, 321.3027729826278, 327.5038316949821, 331.150598714298, 336.31559775856135, 6592.208934927803, 6708.060871477997, 6709.731610735571, 6736.831579210516, 6754.696038678265, 6578.309277525863, 6691.130153080105, 6740.966295168518, 6762.526623136382, 6809.387155156035, 4987.775550100254, 5034.1945288753805, 5038.244263360489, 5038.7984480620735, 5052.343195384595, 4705.1530724469585, 4760.857174284777, 4892.77982490787, 5022.6233032522705, 5039.269305950635, 3974.4237085622567, 4929.4824043475455, 4951.55436010759, 4970.179920313144, 4974.87562810929, 4008.5790991945864, 5010.774515146827, 5010.924836127461, 5017.849464516052, 5018.447970723254, 4262.808173632194, 4263.296556068245, 4269.914601707979, 4270.572942705736, 4272.551382104896, 6247.843803904893, 6446.709898054599, 6449.54853160279, 6487.221533415973, 6517.51118666102, 4935.9753201234125, 5838.97817881869, 5907.350191478934, 5926.911096333559, 5948.13752005961, 5745.2476994516655, 7197.568145911262, 7261.056062711867, 7271.0547628808445, 7271.745488907915, 4515.977420112911, 4674.672772905898, 4679.204535229019, 4781.641376896747, 4797.784099715486, 6217.4715149212825, 7668.769936901902, 7747.883781743279, 7762.805929851799, 7766.689332426696, 3886.7473614214987, 4503.639708823286, 4730.692504987165, 4733.786979585927, 4736.621070314367, 3805.6765174959883, 4673.883152921137, 4673.929891051637, 4676.672632915664, 4696.272077827942, 5551.000819852466, 5656.971715141481, 5768.0, 5816.098504731774, 5816.360200377955, 6207.751689932352, 7341.119065712042, 7351.411887049023, 7352.669129889167, 7371.594562299125, 1599.4002249156567, 1657.6353202295475, 1674.2382216091648, 1674.8660107191395, 1678.261564911435, 876.9956150219208, 1060.5174645536263, 1062.8512008318842, 1066.8346406307035, 1067.3435836960368, 6710.630915299607, 6744.089547911068, 6747.156605424322, 6754.0, 6774.0, 7575.848483030419, 7577.0, 7580.3556697681315, 7581.355584775246, 7582.582957937256, 6466.482681385478, 6710.9262517996885, 6736.7642132525125, 6754.3921047106, 6758.121444212221, 3990.2618015667194, 4035.1841671248058, 4037.2531081749385, 4041.5756345583877, 4042.2521833460905, 7610.733624323122, 7613.6573854176695, 7623.0, 7623.809404764926, 7632.0, 6349.936500635027, 7542.245775422523, 7843.254890785366, 7853.764387068397, 7854.136045035041, 7582.393408527305, 7585.924140758632, 7588.582627955516, 7597.696092156252, 7599.01212842327, 6560.3111673273615, 7432.591207483641, 7535.095788505414, 7554.0, 7564.167941526538, 5979.4618484336615, 7150.749723759852, 7454.92545074564, 7461.0, 7461.328480436787, 7598.772036838683, 7600.657970391235, 7603.201663825219, 7603.847923041619, 7620.657070431955, 4545.931811022903, 4632.3977882875015, 4644.9767751161025, 4653.883652908705, 4749.503906269514, 6535.790878687458, 7067.681954312171, 7536.020317358928, 7585.065808218869, 7586.9620651898595, 7256.0, 7256.4194864409665, 7273.236310187354, 7303.196648368569, 7306.305900939402, 7065.434765218873, 7233.529820561646, 7242.420606351585, 7254.0, 7313.414926805949, 7142.142942846892, 7151.356377926011, 7164.749233776793, 7168.498205125591, 7170.42636589082, 7176.923461480819, 7313.707451702086, 7323.194448610542, 7361.411087113125, 7370.926290737024, 5772.94227057724, 7183.425325973805, 7186.532875363085, 7211.2428195038765, 7214.098237720285], "unit": "ms", "name": "prototype.html", "value": 5217.535140883379}, {"lowerIsBetter": false, "replicates": [736.2269616902252, 773.5629369406284, 775.9534427934325, 812.4353574265884, 835.1606635331491, 14946.5516034519, 15448.918575699692, 15478.61303467411, 15481.071135731863, 15485.14831684257, 14182.787258191136, 14270.2864856757, 14286.928565357159, 14289.499867504639, 14320.498782542612, 749.3068911257106, 764.0716529416758, 765.5827573972199, 768.4927947554615, 947.1712251779693, 948.33616468472, 951.5908159491416, 967.632299726103, 968.6803354892868, 969.3505351414569, 1008.7881544875548, 1019.5564929255761, 1022.2588623248123, 1023.4166525080707, 1024.6311327921978, 797.4736673795296, 810.7648781853255, 811.6347643560422, 992.7369247149511, 1004.5931397783909, 753.8567672142275, 757.8105473631592, 759.3128218961848, 760.2017881224747, 762.0702742654008, 14840.480583179537, 15000.399984000627, 15007.099574025593, 15018.174000429972, 15032.17323047232, 12330.63008109758, 12791.104622676416, 12807.231566106064, 12941.0, 12967.416466259041, 8368.958155209186, 8403.327733781283, 10086.848697269546, 10177.236707246986, 10233.64182253625, 3563.429851223792, 3635.4001589737663, 3645.325614761278, 3658.176910195185, 3792.4500947362753, 77183.84224236642, 78019.0, 79840.0, 79912.00219994488, 80062.19937800606, 9596.280278979104, 9636.46999415039, 9674.08096230857, 9797.412155270707, 9924.255680823822, 22066.66899996501, 22067.0, 22074.88962555177, 22081.0, 22120.44698882541, 7434.293742094493, 7565.773026809205, 7636.121845987783, 7816.022997125359, 7826.295633393022, 3484.7038001770134, 4018.9799051005143, 4098.610631989956, 4103.4050062741335, 4112.054227527626, 3471.600765911902, 3512.2448673535314, 3515.455104458813, 3521.207728261121, 3525.1715846775987, 613.4601550635501, 629.719774700254, 631.2204427532087, 647.8153726188013, 649.6459429610874, 534.7993754022245, 573.4724053870449, 578.4302462074853, 609.135028259872, 618.2426527503771, 9012.233960113334, 9057.637694492278, 9228.676996305232, 9315.956041765388, 9394.389364691273, 502.8290381270386, 522.7699812082672, 601.7472661482188, 618.153130211613, 620.4973971083436, 3920.5099362579676, 4007.479027726377, 4011.13760541485, 4125.91748165041, 4151.445362134687, 92257.0, 93721.53139234397, 93767.0, 94039.0, 94518.5274073639, 65145.0, 69581.95627065598, 80936.19063809287, 84036.57981710053, 85162.0, 72143.55712885712, 72243.99999999895, 73208.0, 73268.0, 73711.0, 8096.352291816758, 8124.512529248264, 8225.177482251727, 8260.83478330442, 8417.368697347845, 41180.79409602933, 48581.0, 50109.997800044526, 51361.74319128381, 51643.0, 67989.64020719657, 72856.63571682108, 73132.63433682798, 73257.0, 74858.62570687111, 8904.55477226149, 9712.5143742814, 10080.99190080986, 10396.272260941661, 10538.367697938149, 9906.900930990887, 11049.01075119389, 11069.5018724156, 12113.878861211628, 12156.939215303866, 9928.751781205528, 10308.622651541173, 10395.376277423378, 10609.416482093558, 10766.623168189075, 9989.350692204984, 10570.630027948984, 10589.841152382567, 11066.502007409525, 11249.1563132767, 10969.670909872717, 11029.393383363991, 11241.81841586692, 11478.138530283091, 12119.620165335298, 7696.961515192388, 9677.516124193622, 9748.366356186825, 9997.500124993576, 10107.595696172071, 8652.913470865211, 9838.9016109838, 10036.397816131055, 10037.247206459691, 10171.64399246023], "unit": "ms", "name": "yui.html", "value": 6914.601335549542}], "name": "dromaeo_css", "value": 7589.859271402533}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 111.0, 110.0, 112.0, 99.0, 111.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [153.0, 149.0, 183.0, 164.0, 116.0, 139.0, 165.0, 149.0, 150.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [198.0, 258.0, 192.0, 179.0, 187.0, 182.0, 186.0, 182.0, 194.0, 260.0], "unit": "ms", "name": "audio-dft", "value": 201.8}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 74.0, 73.0, 54.0, 57.0, 57.0, 73.0, 74.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 64.7}, {"lowerIsBetter": true, "replicates": [82.0, 86.0, 114.0, 75.0, 75.0, 74.0, 111.0, 75.0, 100.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 88.0, 88.0, 89.0, 88.0, 102.0, 134.0, 114.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 96.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 99.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [85.0, 96.0, 141.0, 85.0, 97.0, 127.0, 85.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 55.0, 55.0, 53.0, 54.0, 55.0, 64.0, 52.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 67.0, 64.0, 65.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 80.0, 81.0, 81.0, 79.0, 82.0, 82.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 129.0, 115.0, 124.0, 126.0, 122.0, 120.0, 118.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [139.0, 123.0, 134.0, 132.0, 130.0, 123.0, 137.0, 135.0, 134.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 64.0, 63.0, 64.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1429.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.41199168892845], "unit": "score", "name": "Richards", "value": 237.86487600000007}, {"lowerIsBetter": false, "replicates": [160.77170418006432], "unit": "score", "name": "DeltaBlue", "value": 411.25395999999995}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [4780.952380952381], "unit": "score", "name": "Decrypt", "value": 55.67530876494026}, {"lowerIsBetter": false, "replicates": [1712.3287671232877], "unit": "score", "name": "RayTrace", "value": 432.1535759999999}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [13333.333333333334], "unit": "score", "name": "Boyer", "value": 49.98472500000001}, {"lowerIsBetter": false, "replicates": [28857.14285714286], "unit": "score", "name": "RegExp", "value": 31.568787128712884}, {"lowerIsBetter": false, "replicates": [748.502994011976], "unit": "score", "name": "Splay", "value": 108.87197600000003}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 20137.45631153917}]} 19:54:30 INFO - RETURN: dromaeo_css: 7589.86 19:54:30 INFO - RETURN: kraken: 1429.40 19:54:30 INFO - RETURN: v8_7: 20137.46 19:54:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20137.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1429.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7589.86"}}} 19:54:30 INFO - Return code: 0 19:54:30 INFO - # TBPL SUCCESS # 19:54:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:54:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:54:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:54:30 INFO - 2015-11-20 19:54:30.799 screenresolution[1674:10486] starting screenresolution argv=screenresolution get 19:54:30 INFO - 2015-11-20 19:54:30.801 screenresolution[1674:10486] Display 0: 1600x1200x32@60 19:54:30 INFO - 2015-11-20 19:54:30.807 screenresolution[1675:10489] starting screenresolution argv=screenresolution list 19:54:30 INFO - Available Modes on Display 0 19:54:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:54:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:54:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:54:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:54:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:54:31 INFO - Intel Iris: 19:54:31 INFO - Chipset Model: Intel Iris 19:54:31 INFO - Type: GPU 19:54:31 INFO - Bus: Built-In 19:54:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:54:31 INFO - Vendor: Intel (0x8086) 19:54:31 INFO - Device ID: 0x0a2e 19:54:31 INFO - Revision ID: 0x0009 19:54:31 INFO - Displays: 19:54:31 INFO - Display: 19:54:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:54:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:54:31 INFO - Display Serial Number: 1600x1200 60 19:54:31 INFO - Main Display: Yes 19:54:31 INFO - Mirror: Off 19:54:31 INFO - Online: Yes 19:54:31 INFO - Rotation: Supported 19:54:31 INFO - Return code: 0 19:54:31 INFO - Running post-action listener: _resource_record_post_action 19:54:31 INFO - Running post-run listener: _resource_record_post_run 19:54:32 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 46433280; Write bytes: 699468288; Read time: 545; Write time: 2352 19:54:32 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 334201344; Write bytes: 337463296; Read time: 26174; Write time: 678 19:54:32 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 44036608; Write bytes: 351629824; Read time: 508; Write time: 1641 19:54:32 INFO - Running post-run listener: _upload_blobber_files 19:54:32 INFO - Blob upload gear active. 19:54:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:54:32 INFO - Copying logs to upload dir... 19:54:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.301339 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-20 19:54:32.172055) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:54:32.175718) ========= 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.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 build_url:https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009367 build_url: 'https://queue.taskcluster.net/v1/task/7oy-tVc3RBSANObsE4_6wA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:54:32.198572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:54:32.198915) ========= 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.uv5lCZySi9/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.jB2YvOBOVn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005061 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:54:32.250835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:54:32.251430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 19:54:32.251876) ========= ========= Total master_lag: 0.21 =========