builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1447942715.36 results: success (0) buildid: 20151119052820 builduid: 766a51b7c64343cbb2ce847ef371ba8d revision: 9a49075671cb62db97b9567a510a0bb361c9114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.361125) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.361516) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.361796) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006490 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.382742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.383023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.397430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.397694) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.447369) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.447662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.448025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.448333) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 06:18:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (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% 224M=0s 2015-11-19 06:18:37 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177858 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.652090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.652370) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017945 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:35.707477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:18:35.707792) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a49075671cb62db97b9567a510a0bb361c9114a --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 9a49075671cb62db97b9567a510a0bb361c9114a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 06:18:37,873 truncating revision to first 12 chars 2015-11-19 06:18:37,873 Setting DEBUG logging. 2015-11-19 06:18:37,873 attempt 1/10 2015-11-19 06:18:37,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a49075671cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 06:18:38,780 unpacking tar archive at: fx-team-9a49075671cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 06:18:36.936161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:36.936476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:36.946411) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:36.946675) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 06:18:36.947077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-19 06:18:36.947445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:18:39 INFO - MultiFileLogger online at 20151119 06:18:39 in /builds/slave/test 06:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:39 INFO - {'append_to_log': False, 06:18:39 INFO - 'base_work_dir': '/builds/slave/test', 06:18:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:39 INFO - 'branch': 'Fx-Team-Non-PGO', 06:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:39 INFO - 'config_files': ('talos/linux_config.py',), 06:18:39 INFO - 'default_actions': ('clobber', 06:18:39 INFO - 'read-buildbot-config', 06:18:39 INFO - 'download-and-extract', 06:18:39 INFO - 'populate-webroot', 06:18:39 INFO - 'create-virtualenv', 06:18:39 INFO - 'install', 06:18:39 INFO - 'run-tests'), 06:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:39 INFO - 'download_minidump_stackwalk': True, 06:18:39 INFO - 'download_symbols': 'ondemand', 06:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:39 INFO - 'installer_path': 'installer.exe', 06:18:39 INFO - 'log_level': 'info', 06:18:39 INFO - 'log_name': 'talos', 06:18:39 INFO - 'log_to_console': True, 06:18:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:18:39 INFO - 'opt_config_files': (), 06:18:39 INFO - 'pip_index': False, 06:18:39 INFO - 'sps_profile': False, 06:18:39 INFO - 'sps_profile_interval': 0, 06:18:39 INFO - 'suite': 'dromaeojs', 06:18:39 INFO - 'system_bits': '64', 06:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:39 INFO - 'title': 'talos-linux64-ix-064', 06:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:39 INFO - 'use_talos_json': True, 06:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:39 INFO - 'work_dir': 'build'} 06:18:39 INFO - ##### 06:18:39 INFO - ##### Running clobber step. 06:18:39 INFO - ##### 06:18:39 INFO - Running pre-action listener: _resource_record_pre_action 06:18:39 INFO - Running main action method: clobber 06:18:39 INFO - rmtree: /builds/slave/test/build 06:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:40 INFO - Running post-action listener: _resource_record_post_action 06:18:40 INFO - ##### 06:18:40 INFO - ##### Running read-buildbot-config step. 06:18:40 INFO - ##### 06:18:40 INFO - Running pre-action listener: _resource_record_pre_action 06:18:40 INFO - Running main action method: read_buildbot_config 06:18:40 INFO - Using buildbot properties: 06:18:40 INFO - { 06:18:40 INFO - "properties": { 06:18:40 INFO - "buildnumber": 2088, 06:18:40 INFO - "product": "firefox", 06:18:40 INFO - "script_repo_revision": "production", 06:18:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:18:40 INFO - "repository": "", 06:18:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:18:40 INFO - "buildid": "20151119052820", 06:18:40 INFO - "slavename": "talos-linux64-ix-064", 06:18:40 INFO - "pgo_build": "False", 06:18:40 INFO - "basedir": "/builds/slave/test", 06:18:40 INFO - "project": "", 06:18:40 INFO - "platform": "ubuntu64_hw", 06:18:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:18:40 INFO - "slavebuilddir": "test", 06:18:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:18:40 INFO - "branch": "fx-team", 06:18:40 INFO - "repo_path": "integration/fx-team", 06:18:40 INFO - "stage_platform": "linux64", 06:18:40 INFO - "builduid": "766a51b7c64343cbb2ce847ef371ba8d", 06:18:40 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:18:40 INFO - }, 06:18:40 INFO - "sourcestamp": { 06:18:40 INFO - "repository": "", 06:18:40 INFO - "hasPatch": false, 06:18:40 INFO - "project": "", 06:18:40 INFO - "branch": "fx-team-linux64-talos", 06:18:40 INFO - "changes": [ 06:18:40 INFO - { 06:18:40 INFO - "category": null, 06:18:40 INFO - "files": [ 06:18:40 INFO - { 06:18:40 INFO - "url": null, 06:18:40 INFO - "name": "https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:18:40 INFO - } 06:18:40 INFO - ], 06:18:40 INFO - "repository": "", 06:18:40 INFO - "rev": "9a49075671cb62db97b9567a510a0bb361c9114a", 06:18:40 INFO - "who": "cbook@mozilla.com", 06:18:40 INFO - "when": 1447942641, 06:18:40 INFO - "number": 6682559, 06:18:40 INFO - "comments": "Backed out changeset 24c5d435977d (bug 1213421) for dt6 leak", 06:18:40 INFO - "project": "", 06:18:40 INFO - "at": "Thu 19 Nov 2015 06:17:21", 06:18:40 INFO - "branch": "fx-team-linux64-talos", 06:18:40 INFO - "revlink": "", 06:18:40 INFO - "properties": [ 06:18:40 INFO - [ 06:18:40 INFO - "buildid", 06:18:40 INFO - "20151119052820", 06:18:40 INFO - "Change" 06:18:40 INFO - ], 06:18:40 INFO - [ 06:18:40 INFO - "builduid", 06:18:40 INFO - "766a51b7c64343cbb2ce847ef371ba8d", 06:18:40 INFO - "Change" 06:18:40 INFO - ], 06:18:40 INFO - [ 06:18:40 INFO - "pgo_build", 06:18:40 INFO - "False", 06:18:40 INFO - "Change" 06:18:40 INFO - ] 06:18:40 INFO - ], 06:18:40 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:18:40 INFO - } 06:18:40 INFO - ], 06:18:40 INFO - "revision": "9a49075671cb62db97b9567a510a0bb361c9114a" 06:18:40 INFO - } 06:18:40 INFO - } 06:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:18:40 INFO - Running post-action listener: _resource_record_post_action 06:18:40 INFO - ##### 06:18:40 INFO - ##### Running download-and-extract step. 06:18:40 INFO - ##### 06:18:40 INFO - Running pre-action listener: _resource_record_pre_action 06:18:40 INFO - Running main action method: download_and_extract 06:18:40 INFO - mkdir: /builds/slave/test/build/tests 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:18:40 INFO - https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/test_packages.json 06:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/test_packages.json 06:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:18:50 INFO - Downloaded 1302 bytes. 06:18:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:18:50 INFO - Using the following test package requirements: 06:18:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'jsshell-linux-x86_64.zip'], 06:18:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:18:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:18:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18: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')]} 06:18:50 INFO - https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:19:18 INFO - Downloaded 21291001 bytes. 06:19:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:19:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:19:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:19:19 INFO - Return code: 0 06:19:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:19:19 INFO - https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:19:21 INFO - Downloaded 21291001 bytes. 06:19:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:19:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:19:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:19:22 INFO - Return code: 0 06:19: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')]} 06:19:22 INFO - https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:19:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:19:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:19:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:19:23 INFO - Downloaded 11130997 bytes. 06:19:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 06:19:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:19:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:19:23 INFO - Return code: 0 06:19: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')]} 06:19:23 INFO - https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:19:30 INFO - Downloaded 55667353 bytes. 06:19:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:19:30 INFO - mkdir: /builds/slave/test/properties 06:19:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:30 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:30 INFO - Contents: 06:19:30 INFO - build_url:https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:19:30 INFO - Running post-action listener: _resource_record_post_action 06:19:30 INFO - Running post-action listener: set_extra_try_arguments 06:19:30 INFO - ##### 06:19:30 INFO - ##### Running populate-webroot step. 06:19:30 INFO - ##### 06:19:30 INFO - Running pre-action listener: _resource_record_pre_action 06:19:30 INFO - Running main action method: populate_webroot 06:19:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:30 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:19:30 INFO - '../fennec_ids.txt'], 06:19:30 INFO - 'tests': ['tcheck2']}, 06:19:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:30 INFO - '--tppagecycles', 06:19:30 INFO - '7'], 06:19:30 INFO - 'tests': ['tsvgm']}}, 06:19:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:19:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:19:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:19:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'tests': ['damp', 'tps']}, 06:19:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['damp', 'tps']}, 06:19:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:19:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:30 INFO - 'other': {'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'other_l64': {'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'other_nol64': {'tests': ['a11yr', 06:19:30 INFO - 'ts_paint', 06:19:30 INFO - 'tpaint', 06:19:30 INFO - 'sessionrestore', 06:19:30 INFO - 'sessionrestore_no_auto_restore']}, 06:19:30 INFO - 'svgr': {'tests': ['tsvgx', 06:19:30 INFO - 'tsvgr_opacity', 06:19:30 INFO - 'tart', 06:19:30 INFO - 'tscrollx', 06:19:30 INFO - 'cart']}, 06:19:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['tsvgx', 06:19:30 INFO - 'tsvgr_opacity', 06:19:30 INFO - 'tart', 06:19:30 INFO - 'tscrollx', 06:19:30 INFO - 'cart']}, 06:19:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'tests': ['tp5o']}, 06:19:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'talos_options': ['--e10s'], 06:19:30 INFO - 'tests': ['tp5o']}, 06:19:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'talos_options': ['--xperf_path', 06:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:30 INFO - 'tests': ['tp5n']}, 06:19:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:30 INFO - 'talos_options': ['--e10s', 06:19:30 INFO - '--xperf_path', 06:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:30 INFO - 'tests': ['tp5n']}}, 06:19:30 INFO - 'talos.zip': {'path': '', 06:19:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:30 INFO - Running post-action listener: _resource_record_post_action 06:19:30 INFO - ##### 06:19:30 INFO - ##### Running create-virtualenv step. 06:19:30 INFO - ##### 06:19:30 INFO - Running pre-action listener: _resource_record_pre_action 06:19:30 INFO - Running main action method: create_virtualenv 06:19:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:30 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 06:19:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:30 INFO - Using real prefix '/usr' 06:19:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:32 INFO - Installing pip.................done. 06:19:32 INFO - Return code: 0 06:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19:32 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')]} 06:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:32 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')]} 06:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:32 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:32 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 06:19:32 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 06:19:32 INFO - Using env: {'DISPLAY': ':0', 06:19:32 INFO - 'HOME': '/home/cltbld', 06:19:32 INFO - 'LANG': 'en_US.UTF-8', 06:19:32 INFO - 'LANGUAGE': 'en_US:en', 06:19:32 INFO - 'LOGNAME': 'cltbld', 06:19:32 INFO - 'MAIL': '/var/mail/cltbld', 06:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:32 INFO - 'MOZ_NO_REMOTE': '1', 06:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:32 INFO - 'NO_EM_RESTART': '1', 06:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:32 INFO - 'PWD': '/builds/slave/test', 06:19:32 INFO - 'SHELL': '/bin/bash', 06:19:32 INFO - 'SHLVL': '1', 06:19:32 INFO - 'TERM': 'linux', 06:19:32 INFO - 'TMOUT': '86400', 06:19:32 INFO - 'USER': 'cltbld', 06:19:32 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:32 INFO - '_': '/tools/buildbot/bin/python'} 06:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:32 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 06:19:32 INFO - Cleaning up... 06:19:32 INFO - Return code: 0 06:19:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:19:32 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')]} 06:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:32 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')]} 06:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:32 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:32 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 06:19:32 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 06:19:32 INFO - Using env: {'DISPLAY': ':0', 06:19:32 INFO - 'HOME': '/home/cltbld', 06:19:32 INFO - 'LANG': 'en_US.UTF-8', 06:19:32 INFO - 'LANGUAGE': 'en_US:en', 06:19:32 INFO - 'LOGNAME': 'cltbld', 06:19:32 INFO - 'MAIL': '/var/mail/cltbld', 06:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:32 INFO - 'MOZ_NO_REMOTE': '1', 06:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:32 INFO - 'NO_EM_RESTART': '1', 06:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:32 INFO - 'PWD': '/builds/slave/test', 06:19:32 INFO - 'SHELL': '/bin/bash', 06:19:32 INFO - 'SHLVL': '1', 06:19:32 INFO - 'TERM': 'linux', 06:19:32 INFO - 'TMOUT': '86400', 06:19:32 INFO - 'USER': 'cltbld', 06:19:32 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:32 INFO - '_': '/tools/buildbot/bin/python'} 06:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:33 INFO - Downloading/unpacking psutil>=0.7.1 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:33 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 06:19:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:19:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:34 INFO - Installing collected packages: psutil 06:19:34 INFO - Running setup.py install for psutil 06:19:34 INFO - building 'psutil._psutil_linux' extension 06:19:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:19:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:19:35 INFO - building 'psutil._psutil_posix' extension 06:19:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:19:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:35 INFO - Successfully installed psutil 06:19:35 INFO - Cleaning up... 06:19:35 INFO - Return code: 0 06:19:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:35 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:35 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 06:19:35 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 06:19:35 INFO - Using env: {'DISPLAY': ':0', 06:19:35 INFO - 'HOME': '/home/cltbld', 06:19:35 INFO - 'LANG': 'en_US.UTF-8', 06:19:35 INFO - 'LANGUAGE': 'en_US:en', 06:19:35 INFO - 'LOGNAME': 'cltbld', 06:19:35 INFO - 'MAIL': '/var/mail/cltbld', 06:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:35 INFO - 'MOZ_NO_REMOTE': '1', 06:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:35 INFO - 'NO_EM_RESTART': '1', 06:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:35 INFO - 'PWD': '/builds/slave/test', 06:19:35 INFO - 'SHELL': '/bin/bash', 06:19:35 INFO - 'SHLVL': '1', 06:19:35 INFO - 'TERM': 'linux', 06:19:35 INFO - 'TMOUT': '86400', 06:19:35 INFO - 'USER': 'cltbld', 06:19:35 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:35 INFO - '_': '/tools/buildbot/bin/python'} 06:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:19:35 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 06:19:35 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 06:19:35 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 06:19:35 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 06:19:35 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 06:19:35 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 06:19:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:19:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:19:37 INFO - Installing collected packages: mozsystemmonitor 06:19:37 INFO - Running setup.py install for mozsystemmonitor 06:19:37 INFO - Successfully installed mozsystemmonitor 06:19:37 INFO - Cleaning up... 06:19:37 INFO - Return code: 0 06:19:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19:37 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')]} 06:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:37 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')]} 06:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:37 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:37 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 06:19:37 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 06:19:37 INFO - Using env: {'DISPLAY': ':0', 06:19:37 INFO - 'HOME': '/home/cltbld', 06:19:37 INFO - 'LANG': 'en_US.UTF-8', 06:19:37 INFO - 'LANGUAGE': 'en_US:en', 06:19:37 INFO - 'LOGNAME': 'cltbld', 06:19:37 INFO - 'MAIL': '/var/mail/cltbld', 06:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:37 INFO - 'MOZ_NO_REMOTE': '1', 06:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:37 INFO - 'NO_EM_RESTART': '1', 06:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:37 INFO - 'PWD': '/builds/slave/test', 06:19:37 INFO - 'SHELL': '/bin/bash', 06:19:37 INFO - 'SHLVL': '1', 06:19:37 INFO - 'TERM': 'linux', 06:19:37 INFO - 'TMOUT': '86400', 06:19:37 INFO - 'USER': 'cltbld', 06:19:37 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:37 INFO - '_': '/tools/buildbot/bin/python'} 06:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:39 INFO - Downloading docopt-0.6.1.tar.gz 06:19:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:40 INFO - Running setup.py install for blobuploader 06:19:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:40 INFO - Running setup.py install for requests 06:19:40 INFO - Running setup.py install for docopt 06:19:40 INFO - Successfully installed blobuploader requests docopt 06:19:40 INFO - Cleaning up... 06:19:40 INFO - Return code: 0 06:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:40 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:40 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 06:19:40 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 06:19:40 INFO - Using env: {'DISPLAY': ':0', 06:19:40 INFO - 'HOME': '/home/cltbld', 06:19:40 INFO - 'LANG': 'en_US.UTF-8', 06:19:40 INFO - 'LANGUAGE': 'en_US:en', 06:19:40 INFO - 'LOGNAME': 'cltbld', 06:19:40 INFO - 'MAIL': '/var/mail/cltbld', 06:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:40 INFO - 'MOZ_NO_REMOTE': '1', 06:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:40 INFO - 'NO_EM_RESTART': '1', 06:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:40 INFO - 'PWD': '/builds/slave/test', 06:19:40 INFO - 'SHELL': '/bin/bash', 06:19:40 INFO - 'SHLVL': '1', 06:19:40 INFO - 'TERM': 'linux', 06:19:40 INFO - 'TMOUT': '86400', 06:19:40 INFO - 'USER': 'cltbld', 06:19:40 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:40 INFO - '_': '/tools/buildbot/bin/python'} 06:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:40 INFO - Running setup.py (path:/tmp/pip-w_vci7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:40 INFO - Running setup.py (path:/tmp/pip-svnF4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:41 INFO - Running setup.py (path:/tmp/pip-iIwDZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:41 INFO - Running setup.py (path:/tmp/pip-8aYGzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:41 INFO - Running setup.py (path:/tmp/pip-Lu4ynW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:41 INFO - Running setup.py (path:/tmp/pip-ka4yRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:41 INFO - Running setup.py (path:/tmp/pip-4Iqj2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:41 INFO - Running setup.py (path:/tmp/pip-tXEfqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:41 INFO - Running setup.py (path:/tmp/pip-59nMdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:41 INFO - Running setup.py (path:/tmp/pip-gKYxjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:41 INFO - Running setup.py (path:/tmp/pip-S1c30s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:41 INFO - Running setup.py (path:/tmp/pip-cCZU4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:41 INFO - Running setup.py (path:/tmp/pip-uvg4kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:41 INFO - Running setup.py (path:/tmp/pip-AX2XJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:41 INFO - Running setup.py (path:/tmp/pip-lS_Kig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:41 INFO - Running setup.py (path:/tmp/pip-fPXUAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:42 INFO - Running setup.py (path:/tmp/pip-G5Jnj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:42 INFO - Running setup.py install for manifestparser 06:19:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozcrash 06:19:42 INFO - Running setup.py install for mozdebug 06:19:42 INFO - Running setup.py install for mozdevice 06:19:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozfile 06:19:42 INFO - Running setup.py install for mozhttpd 06:19:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozinfo 06:19:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozInstall 06:19:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozleak 06:19:42 INFO - Running setup.py install for mozlog 06:19:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for moznetwork 06:19:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozprocess 06:19:43 INFO - Running setup.py install for mozprofile 06:19:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozrunner 06:19:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozscreenshot 06:19:43 INFO - Running setup.py install for moztest 06:19:43 INFO - Running setup.py install for mozversion 06:19:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:43 INFO - Cleaning up... 06:19:43 INFO - Return code: 0 06:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:43 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')]} 06:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:43 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')]} 06:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:43 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:43 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 06:19:43 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 06:19:43 INFO - Using env: {'DISPLAY': ':0', 06:19:43 INFO - 'HOME': '/home/cltbld', 06:19:43 INFO - 'LANG': 'en_US.UTF-8', 06:19:43 INFO - 'LANGUAGE': 'en_US:en', 06:19:43 INFO - 'LOGNAME': 'cltbld', 06:19:43 INFO - 'MAIL': '/var/mail/cltbld', 06:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:43 INFO - 'MOZ_NO_REMOTE': '1', 06:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:43 INFO - 'NO_EM_RESTART': '1', 06:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:43 INFO - 'PWD': '/builds/slave/test', 06:19:43 INFO - 'SHELL': '/bin/bash', 06:19:43 INFO - 'SHLVL': '1', 06:19:43 INFO - 'TERM': 'linux', 06:19:43 INFO - 'TMOUT': '86400', 06:19:43 INFO - 'USER': 'cltbld', 06:19:43 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:43 INFO - '_': '/tools/buildbot/bin/python'} 06:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:44 INFO - Running setup.py (path:/tmp/pip-zFbD96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:44 INFO - Running setup.py (path:/tmp/pip-wLxBX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:44 INFO - Running setup.py (path:/tmp/pip-08jeld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:44 INFO - Running setup.py (path:/tmp/pip-OQawbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:44 INFO - Running setup.py (path:/tmp/pip-xgyBsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:44 INFO - Running setup.py (path:/tmp/pip-Y_ni_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:44 INFO - Running setup.py (path:/tmp/pip-t3BwwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:44 INFO - Running setup.py (path:/tmp/pip-47YgX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:44 INFO - Running setup.py (path:/tmp/pip-WH5fwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:44 INFO - Running setup.py (path:/tmp/pip-VhmB7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:44 INFO - Running setup.py (path:/tmp/pip-AURAo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:44 INFO - Running setup.py (path:/tmp/pip-FAdFZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:44 INFO - Running setup.py (path:/tmp/pip-gLNIlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:45 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)) 06:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:45 INFO - Running setup.py (path:/tmp/pip-DGTwhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:45 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)) 06:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:45 INFO - Running setup.py (path:/tmp/pip-2WpttX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:45 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)) 06:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:45 INFO - Running setup.py (path:/tmp/pip-0PT_Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:45 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)) 06:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:45 INFO - Running setup.py (path:/tmp/pip-29_ce_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:46 INFO - Downloading blessings-1.5.1.tar.gz 06:19:46 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 06:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:47 INFO - Installing collected packages: blessings 06:19:47 INFO - Running setup.py install for blessings 06:19:47 INFO - Successfully installed blessings 06:19:47 INFO - Cleaning up... 06:19:47 INFO - Return code: 0 06:19:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:47 INFO - Reading from file tmpfile_stdout 06:19:47 INFO - Current package versions: 06:19:47 INFO - argparse == 1.2.1 06:19:47 INFO - blessings == 1.5.1 06:19:47 INFO - blobuploader == 1.2.4 06:19:47 INFO - docopt == 0.6.1 06:19:47 INFO - manifestparser == 1.1 06:19:47 INFO - mozInstall == 1.12 06:19:47 INFO - mozcrash == 0.16 06:19:47 INFO - mozdebug == 0.1 06:19:47 INFO - mozdevice == 0.47 06:19:47 INFO - mozfile == 1.2 06:19:47 INFO - mozhttpd == 0.7 06:19:47 INFO - mozinfo == 0.9 06:19:47 INFO - mozleak == 0.1 06:19:47 INFO - mozlog == 3.0 06:19:47 INFO - moznetwork == 0.27 06:19:47 INFO - mozprocess == 0.22 06:19:47 INFO - mozprofile == 0.27 06:19:47 INFO - mozrunner == 6.11 06:19:47 INFO - mozscreenshot == 0.1 06:19:47 INFO - mozsystemmonitor == 0.0 06:19:47 INFO - moztest == 0.7 06:19:47 INFO - mozversion == 1.4 06:19:47 INFO - psutil == 3.1.1 06:19:47 INFO - requests == 1.2.3 06:19:47 INFO - wsgiref == 0.1.2 06:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:47 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')]} 06:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 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')]} 06:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 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 0x7f46e422ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d526c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e03900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:47 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 06:19:47 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 06:19:47 INFO - Using env: {'DISPLAY': ':0', 06:19:47 INFO - 'HOME': '/home/cltbld', 06:19:47 INFO - 'LANG': 'en_US.UTF-8', 06:19:47 INFO - 'LANGUAGE': 'en_US:en', 06:19:47 INFO - 'LOGNAME': 'cltbld', 06:19:47 INFO - 'MAIL': '/var/mail/cltbld', 06:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:47 INFO - 'MOZ_NO_REMOTE': '1', 06:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:47 INFO - 'NO_EM_RESTART': '1', 06:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:47 INFO - 'PWD': '/builds/slave/test', 06:19:47 INFO - 'SHELL': '/bin/bash', 06:19:47 INFO - 'SHLVL': '1', 06:19:47 INFO - 'TERM': 'linux', 06:19:47 INFO - 'TMOUT': '86400', 06:19:47 INFO - 'USER': 'cltbld', 06:19:47 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:47 INFO - '_': '/tools/buildbot/bin/python'} 06:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 INFO - Cleaning up... 06:19:47 INFO - Return code: 0 06:19:47 INFO - Running post-action listener: _resource_record_post_action 06:19:47 INFO - Running post-action listener: _start_resource_monitoring 06:19:47 INFO - Starting resource monitoring. 06:19:47 INFO - ##### 06:19:47 INFO - ##### Running install step. 06:19:47 INFO - ##### 06:19:47 INFO - Running pre-action listener: _resource_record_pre_action 06:19:47 INFO - Running main action method: install 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:47 INFO - Reading from file tmpfile_stdout 06:19:47 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:19:47 INFO - Reading from file tmpfile_stdout 06:19:47 INFO - Output received: 06:19:47 INFO - Usage: mozinstall [options] installer 06:19:47 INFO - Options: 06:19:47 INFO - -h, --help show this help message and exit 06:19:47 INFO - -d DEST, --destination=DEST 06:19:47 INFO - Directory to install application into. [default: 06:19:47 INFO - "/builds/slave/test"] 06:19:47 INFO - --app=APP Application being installed. [default: firefox] 06:19:47 INFO - mkdir: /builds/slave/test/build/application 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:20:02 INFO - Reading from file tmpfile_stdout 06:20:02 INFO - Output received: 06:20:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:20:02 INFO - Running post-action listener: _resource_record_post_action 06:20:02 INFO - ##### 06:20:02 INFO - ##### Running run-tests step. 06:20:02 INFO - ##### 06:20:02 INFO - Running pre-action listener: _resource_record_pre_action 06:20:02 INFO - Running main action method: run_tests 06:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:20:02 INFO - Python 2.7.3 06:20:02 INFO - Return code: 0 06:20:02 INFO - grabbing minidump binary from tooltool 06:20:02 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')]} 06:20:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49b70>, '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 0x1e9adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9b250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:20:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:20:02 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/linux64/releng.manifest -o -c /builds/tooltool_cache 06:20:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:20:02 INFO - Return code: 0 06:20:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:20:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:20:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:20:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:20:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] in /builds/slave/test/build 06:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost 06:20:02 INFO - Using env: {'DISPLAY': ':0', 06:20:02 INFO - 'HOME': '/home/cltbld', 06:20:02 INFO - 'LANG': 'en_US.UTF-8', 06:20:02 INFO - 'LANGUAGE': 'en_US:en', 06:20:02 INFO - 'LOGNAME': 'cltbld', 06:20:02 INFO - 'MAIL': '/var/mail/cltbld', 06:20:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:20:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:02 INFO - 'MOZ_NO_REMOTE': '1', 06:20:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:02 INFO - 'NO_EM_RESTART': '1', 06:20:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:02 INFO - 'PWD': '/builds/slave/test', 06:20:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:20:02 INFO - 'SHELL': '/bin/bash', 06:20:02 INFO - 'SHLVL': '1', 06:20:02 INFO - 'TERM': 'linux', 06:20:02 INFO - 'TMOUT': '86400', 06:20:02 INFO - 'USER': 'cltbld', 06:20:02 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451', 06:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:02 INFO - '_': '/tools/buildbot/bin/python'} 06:20:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] with output_timeout 3600 06:20:02 INFO - mozversion INFO | application_buildid: 20151119052820 06:20:02 INFO - mozversion INFO | application_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:20:02 INFO - mozversion INFO | application_display_name: Nightly 06:20:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:20:02 INFO - mozversion INFO | application_name: Firefox 06:20:02 INFO - mozversion INFO | application_remotingname: firefox 06:20:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:20:02 INFO - mozversion INFO | application_vendor: Mozilla 06:20:02 INFO - mozversion INFO | application_version: 45.0a1 06:20:02 INFO - mozversion INFO | platform_buildid: 20151119052820 06:20:02 INFO - mozversion INFO | platform_changeset: 9a49075671cb62db97b9567a510a0bb361c9114a 06:20:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:20:02 INFO - mozversion INFO | platform_version: 45.0a1 06:20:02 INFO - 2015-11-19 06:20:02,312 DEBUG : using testdate: 1447942802 06:20:02 INFO - 2015-11-19 06:20:02,312 DEBUG : actual date: 1447942802 06:20:02 INFO - 2015-11-19 06:20:02,320 INFO : starting webserver on 'localhost:38809' 06:20:02 INFO - 2015-11-19 06:20:02,321 INFO : Starting test suite talos-linux64-ix-064 06:20:02 INFO - 2015-11-19 06:20:02,321 INFO : Starting test dromaeo_css 06:20:02 INFO - 2015-11-19 06:20:02,321 DEBUG : operating with platform_type : linux_ 06:20:02 INFO - 2015-11-19 06:20:02,322 INFO : Initialising browser for dromaeo_css test... 06:20:02 INFO - 2015-11-19 06:20:02,339 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJj7cwD/profile http://localhost:38809/getInfo.html 06:20:07 INFO - 2015-11-19 06:20:07,157 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:20:07 INFO - 2015-11-19 06:20:07,157 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:20:07 INFO - 2015-11-19 06:20:07,157 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:20:07 INFO - 2015-11-19 06:20:07,157 DEBUG : BROWSER_OUTPUT: __metrics 06:20:07 INFO - 2015-11-19 06:20:07,274 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:08 INFO - 2015-11-19 06:20:08,458 INFO : Browser initialized. 06:20:08 INFO - 2015-11-19 06:20:08,458 INFO : Running cycle 1/1 for dromaeo_css test... 06:20:08 INFO - 2015-11-19 06:20:08,459 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJj7cwD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:20:20 INFO - 2015-11-19 06:20:20,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 139157504 06:20:20 INFO - 2015-11-19 06:20:20,353 DEBUG : BROWSER_OUTPUT: 06:21:11 INFO - 2015-11-19 06:21:11,644 DEBUG : BROWSER_OUTPUT: 1447942871644 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] 06:23:23 INFO - 2015-11-19 06:23:23,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38809/tests/dromaeo/cssquery-ext.html) 06:23:24 INFO - 2015-11-19 06:23:24,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 249171968 06:23:24 INFO - 2015-11-19 06:23:24,459 DEBUG : BROWSER_OUTPUT: 06:26:26 INFO - 2015-11-19 06:26:26,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-ext.html (next: http://localhost:38809/tests/dromaeo/cssquery-jquery.html) 06:26:27 INFO - 2015-11-19 06:26:27,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 218120192 06:26:27 INFO - 2015-11-19 06:26:27,551 DEBUG : BROWSER_OUTPUT: 06:29:29 INFO - 2015-11-19 06:29:29,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38809/tests/dromaeo/cssquery-mootools.html) 06:29:30 INFO - 2015-11-19 06:29:30,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 206155776 06:29:30 INFO - 2015-11-19 06:29:30,207 DEBUG : BROWSER_OUTPUT: 06:32:32 INFO - 2015-11-19 06:32:32,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38809/tests/dromaeo/cssquery-prototype.html) 06:32:32 INFO - 2015-11-19 06:32:32,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 199532544 06:32:32 INFO - 2015-11-19 06:32:32,763 DEBUG : BROWSER_OUTPUT: 06:35:35 INFO - 2015-11-19 06:35:35,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38809/tests/dromaeo/cssquery-yui.html) 06:35:36 INFO - 2015-11-19 06:35:36,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 205328384 06:35:36 INFO - 2015-11-19 06:35:36,123 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/dromaeo/cssquery-yui.html (next: http://localhost:38809/tests/dromaeo/cssquery-dojo.html) 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 268988416 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:38:38 INFO - 2015-11-19 06:38:38,746 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.055699948019;2707.6750789905213;2717.076194094008;2719.578465337873;2723.645926029617;4392.341148827678;4536.886577835556;4644.883877903054;4665.2069148244755;4726.149293127236;4665.696729712575;4713.505081966396;4714.693544919578;4786.736729479886;4797.6401769867225;4253.957460425395;4365.43249377582;4380.299152135659;4517;4545.52272011439;4453.799579018936;4472.150291444631;4506.076254367863;4527.886802829923;4556.906342477814;4154.293770059082;4254.425652536899;4263.850765223233;4340.826366945318;4363.040131171138;4317.201317756225;4331.155424692186;4345.087531618364;4346.15250026245;4353.238183317907;4080.5307389650275;4271.722338048017;4290.485141783006;4297.247981603207;4340.826366945318;4515.977420112911;4536.977315113436;4624.468186158568;4650.232711602582;4679.368285281512;5059.949400505985;5061.898762024775;5066.442691303953;5074.847754567369;5106.4638212987475;4859.441164266084;4985.950140498585;5086.872828179326;5089.694618322913;5104.183330667112;4548.681592288541;4566.45202575693;4637.791299391535;4660.603848672833;4709.505501922317;5213.2701421800975;5214.687118772886;5214.895702085937;5233.947660523346;5256.2115682647145;4751.097291514601;4892.804287828518;4985.825496107619;4990.051890140861;5012.172991456368;4965.925511117336;5092;5203.583713302926;5211.635185537052;5225.529702326809;5110.233464980282;5154.664946778447;5156.639035267495;5164.225366195101;5196.012757576124;4654.790534425959;4772.0217355442055;5086.21163719624;5125.384953805493;5126.179811230185;4154.31453810124;4186.644135248538;4219.578042195817;4244.724092934011;4259.339802330644;3718.9772812476244;3762.3039737648623;3766.60450652683;3767.246550689873;3788.734788564774;4208.537060923296;4404.933925991113;4421.314696222091;4426.092651006536;4464.977675111603;4997.525235102659;4999.150144475448;5026.673266237683;5088.084144853888;5128.205128205134;4385.780710964439;4414.514403415622;4419.911601767946;4422.425084738963;4456.866294011184;4258.723182993095;4561.315802629566;4563.771811409416;4566.063956888896;4607.3089036644105;4672.836450724209;4698.036902434924;4729.574338309569;4827.155247831685;4859.781309840995;5114;5182.24857395683;5185.559227465556;5188.55897248723;5188.610854185876;4914.70511769295;4915.238138088602;4918.2376731606655;4920.901581968412;4926.3842019747535;4825;4913.06651736169;4955.776990035529;4957.975210123926;5062.31658726082;5173.870653233699;5191.844244672666;5192.610554208374;5194.246834209094;5197.610179236497;4954.5540901319055;4960.70235785854;4964.329815475009;4971.37857767779;5005.674631148963;4562.315652652129;4689.179393606173;4691.530846915418;4755.239161734106;4877.5366340197625;4869.756512174448;4892.119418504703;4902.485239049991;4916.139675556692;4940.975295123501;5025.723585202849;5056.292119103255;5058.721770302669;5059.696418214919;5092.541671249605;4590.403247577793;4668.229742092517;4721.834735784231;4724.976375118103;4806.327114204084 06:38:38 INFO - 2015-11-19 06:38:38,747 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.4165909113613;570.7945139749688;573.5755540899736;580.8199458167971;589.3605438099662;28369.858150709242;36719.63280367196;37404.812975935085;37505.437418438676;37628.623713762856;40493.39259911104;41052.38421423681;41061.38407923884;41100.177996440056;41194.79402602983;7004.894926576106;7124.5012849100585;7955.840883182347;8120.512769233836;8124;10187.134093602053;10455.268131230818;10459.581616735322;10460.320079194866;10472.842907356397;9968.152707019912;10127.189824814033;10133.94933025334;10135.44255065971;10138.239632027591;9867.210623150131;9952.253580981383;9955.800883982352;9958.4024958502;9972.60109595619;9890.604375824958;10054.497275136215;10072.899271007269;10083.798324033478;10089.041541053588;38224.42663360052;38364.42453363202;38367.616323836686;38370.80814595909;38642;2838.5884046813303;2852.073076250227;2905.2155917902046;3485;3676.6323367663285;28494.71505284962;28846.980711350214;28880.133595992153;29410;29857.85071074631;2918.299608094042;2926.6926972667775;2954.23189970607;3061.11227743954;3070.9385812283854;218156;219577;219618;220048;220195;46180.5381946183;47752.522474775506;53915;54839.72580137074;55549.16676249859;49983.500164998615;50329.74835125801;50382;50570.74714626403;50611.48165554966;12106.273623582612;12178.695532611755;12196.085293603015;12310.138290319592;12313.26120432777;8265.917340826634;8518.063013068557;9016.774580635536;9312.534373281444;9370.203532699661;18893.433197004113;19102.33141840057;19133.80866191348;19146.138423770964;19160.712589310893;7206.423486121098;7342.229065947999;7463.843104318839;7487.213842546563;7535.849283014309;771.6951804037486;779.5283853268804;827.5696637748338;848.3394154224502;970.257752819094;26999.73000269972;27097.729022709915;27299.45401091967;27423.725762742517;27457.86271068632;917.8230508676644;919.7010971434311;962.37926537383;1017.6692574913183;1094.8467214589964;13886.166829990232;14128.152310861382;14541.927290363481;14706.264686765619;14763.483278085216;205473;208899;209435;209540;210064;42368.788156059636;42712.57287427148;42736.78631606822;42795.57204427978;42833.57166428358;1110.5613282753268;1118.6028959719345;1124.668222874254;1127.3912087472836;1132.399828091113;25307.620385693863;26156.60765088563;26344.736552634997;26446;26599.335016623965;36306;39846.60153398545;39940.8002959995;40094.799526002185;40116;163150;242688;251563;251903;252294;26031.088911887993;26567.468650627266;26568.468630627667;26643.7335626649;26668;34776;38228.235435291695;38922.6107738919;39875.40186897257;40057.599424005384;33393.33213335768;33725.32549349048;34292.314153717285;34908;34952.82523587366;32011.35977280488;33618.49572256369;34318.313633726684;34376.312473750884;34438.827805861816;32572;33227.33545329032;33258;33557;33762.987110386726;27617.723822761516;28295.575566366933;30580;30997;31010.689893101684;22153.889230553745;22197.334079977627;30419.54370684486;32664.183395414355;33101.17247068843 06:38:38 INFO - 2015-11-19 06:38:38,747 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.4109647831445;310.3234947813765;311.1753852291428;311.6727436191999;312.23813894098396;12564.748705025893;12935.094543381967;16227.513174604766;16770.413035543745;16841.831581684193;12844.486220551167;12875.484980600788;12915.806262906064;13018.34908254586;14967.92516037421;4904.288878112671;4959.70241785494;4960.131976904046;5109.616778741591;5110.28456016158;3522.5068490411236;3629.1652919828457;5004.549590536851;5037.118504261758;5038.496150384969;5378.973105134469;5521.254630624854;5527.751251193706;5553.694546799945;5570.470805273492;4531.229690952546;4666.160091183586;5534.391216966131;5539.501444869961;5540.833774986757;4012.979935100335;4019.417184508259;4020.115574573589;4022.658074063708;4023.3160362738404;10856.077233435168;10977.945110274477;11081.27971681838;11637;11650.300981941025;1700.6598680263996;1726.4906852478548;1726.6891959447294;1742.0505824325774;1783.8126996665294;8495.617697203641;8614;8943;8999.19007289347;9006.819863602692;1549.0559348018278;1588.5393235961558;1592.2277695317762;1603.5029140966337;1630.9266083026291;50955.49044509544;51407.74296128533;52240.21639675408;52847.73576132133;53105.7344713274;6067.332593414721;6096.969515152485;6113.205283313141;6125.356837531995;6157.96921015392;7144.785656430316;7148.964255178691;7157.427405807627;7161.89257161143;7162.997180394749;4552.0668263006;4557.339185818038;4596.35651008859;4614.630829533629;4659.976700116477;4489.34904438861;4594.379758732528;4623.838165664186;4646.581807637329;4650.488446270908;2792.720727927191;2795.3850152966315;2822.647169103862;2827.2649111231226;2835.4470878178968;994.125169850527;996.4021587047713;1002.9498525073863;1034.1984961654778;1055.472263868066;353.32338571635546;386.37021654702653;397.80507551299655;399.8860324807416;406.315358620725;9886.25853061009;10462.319949203278;10492.108170805413;10739.892601074045;10820.458977051116;405.8376649340228;412.8761371588511;418.30978884839647;422.1009250296848;445.3809205204768;5424.728763561885;5694.743736531866;5725.713714314267;5792.449717276936;5831.7667293307795;312522;315441;317823;319305;415500;56676.71661641748;62112;62640.68679656664;69014.65492672606;69872;451.07754641757685;459.6920063557425;462.6345187301994;463.88866671998477;465.5367908930636;9456.810863782823;9476.147146756824;9526.571304291461;9677.274204434836;9691.07934746198;30149.849250753607;30701;31995.200119996254;32317.676823231468;32459.18852028718;37052;37992.62007380001;40337.79831100826;41195.38206926958;42854.35718464288;5967.582269241111;6064.575479716377;6155.846103847261;6167.722452489738;6171.321154672893;9566.186874115778;10809.0812280957;10873;10874;11160.404136644056;8147.1038185798325;8154.592270386338;8744.344174186834;8883.067277935723;9050.728478145666;8864.955675221583;9133.588988495667;9166.54167291646;9227.86158207614;9383.906160938302;9170.220531254652;9179.311551633788;9216.769580760534;9328.440293582407;9423.57593908262;13593;13964.511242106477;14092.859071409155;14160.079594826304;14199;12601.621951341474;12993.155444896052;13248.933755331162;14555.92722036383;14938.477153299582 06:38:38 INFO - 2015-11-19 06:38:38,748 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.1734418021274;1594.5535250129965;1635.6973959817435;1660.6844699507096;1673.6150685342363;5616.719164041797;6497.317781632925;6707;6711.664416779166;6718.79843604692;6604.801855944317;6696.4642828573715;6699.732010719566;6707;6709.228438729548;1649.7442896351085;1677.8406051425095;1917.0702209428416;2001.7497812773368;2029.502771820906;1950.882947023183;1953.2870502266642;1968.4980330015826;1970.5566247594247;1971.0637447212532;1909.9809001910012;1929.5465565592074;1979.613975274822;1982.2368388170587;1982.6133903888747;1921.164293532318;1943.7570303712037;1964.5776158126;1966.9508262293414;1967.803219678028;1955.6186543623999;1957.0801723190077;1974.2793880233755;1976.5651556657513;1977.5352792093847;6690.899636505456;6736.46108311334;6749;6770;6772.52592318533;3975.920481590352;4059.533153687334;4059.6955228357697;4063.2686116499017;4064.04494943688;2250.63989761639;2628.303499572615;2815.7888158388;2836.8156069855395;2840.5313123334627;751.3538357012965;805.9314958228557;853.6116067189414;862.7368652560966;864.658459908339;8908.821823563492;8999.595018224196;9017.954910225473;9021.503817290046;9026.458412495205;3672.4491326300736;3712.6101759315425;3770.4155855842387;3776.3013842439236;3803.980980095082;7855.175206603339;7872.212778722196;7874.606269686493;7877.842443151105;7879.803004924923;4117.691173161965;4131.091159944807;4136.958630413717;4145.564715704868;4147.232761939051;3751.212245428436;3767.0770661188185;3771.75483593571;3777.56557995834;3781.149241420713;3230.07942736319;3230.5154226866157;3263.379957808009;3265.069455205255;3268.5587445695;999.980000399988;1007.4660429972126;1034.9896501035043;1038.5741845843168;1039.7088815131776;1112.449337577904;1115.4645770030431;1132.8130858408435;1138.1009002887627;1150.9366984815747;6223.408776166257;6246;6247.375262473716;6277.5605707600025;6279.843003924939;1060.2949038889053;1078.3314345106085;1087.5486673030603;1107.4905543449943;1111.955521779136;4829.396325459317;4858.222684370484;4858.684185527929;4864.124457597595;4883.804647814048;6594.439472644783;6823.454123670094;7633.847323053508;7740;7812.882806757903;7827.373810095179;7931.960340198262;7981.600919953979;8005.199480051948;8016.879746803803;6445.838854028593;6454.774082907075;6529.477641788645;6544.051112588648;6556.672166391661;6249.187605611241;6270.310265870842;6286.774079054723;6297.559170857996;6326.683665816783;7188.4968052235845;7233;7251.166115896739;7324.121105467378;7333.046703928455;6920.9307906920285;7136.928630713626;7392.926070739224;7535.321821036133;7537.057867766529;5881;5959.642421454727;5961.254843144607;5963.224780778471;5964.254468191476;6532.477401807749;6590.308017658077;6607.438367738604;6611.33886611335;6629.668516574248;6220.595661282002;6220.657863817533;6276.529260305404;6305.464035557029;6363.6818159090935;6184.5052395809125;6190.659513726789;6247.812565623039;6259.15354970294;6299.338569450142;6099.2985806632805;6260.686965651608;6282.465990390685;6304.338044505261;6325.715342809676;5839.970800145972;5865.73604187804;5869.236999190078;5878.970605146947;5885.440883116097;5719.656820590778;5760.308762948473;5763.250777399079;5775.768969241183;5776.7111644418455 06:38:38 INFO - 2015-11-19 06:38:38,749 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.33100224961214;281.7281323522801;285.3565210450434;287.42228121475813;288.98699558519866;5184.300119483869;5266.841994740154;5341.946580534193;5363.088274993251;5425.321834770659;4817.132916075105;5275.050490911634;5290.55030322423;5320.228566857803;5345.251664766926;4138.606832350922;4142.591518883579;4142.606452387018;4143.70994030418;4151.335786274197;3937.114149316395;4033.144753413433;4045.2516284487465;4130.958690413103;4148.004478925051;4074.2666320062376;4113.670906327501;4114.177164567083;4118.299889018859;4120.237756015147;4096.180763847243;4103.384492326145;4106.835726570934;4109.075458021951;4115.773632450214;3575.8748443804343;3577.105723569108;3580.104973756561;3589.407747721623;3593.802340871251;5167.302414174113;5170.431252562215;5172.456892026321;5174.741262936838;5179.04187725272;4739.9526004739855;4741.739204343759;4759.048190361941;4761.761911904391;4763.023580166057;5648.802291919763;5652.9152062719095;5658.321001479808;5658.349289831681;5662.065759149736;3913.2760439318818;3929.626685464876;3930.941035884464;3932.7640341579595;3934.5475270343704;5485.561155107622;5915.940840591582;5916.053431450947;5918.053111502139;5920.526357891358;3706.9073273168387;3809.923801523954;3910.511186101737;3915.0016745730227;3918.8432462701744;3952.8616498422416;3979.5025621797276;3983.103801644607;4026.375911733686;4054.4729185206324;4521.231390663595;4599.379083823641;4614.76926153691;4661.533846615379;4670.8365207217585;5640.464155905182;5647.37878833328;5650.604457688005;5651.576131790132;5651.632643878217;1419.049237011205;1421.3603878254826;1424.4871846135384;1425.0737020936474;1426.172819764534;964.0889359555293;966.2077096780572;966.4008314844841;976.2385339435252;978.1001478639527;4956.207006878882;4971.6271279654175;4974.129527332775;4974.90050198994;4984.3021976923255;5866.442687944638;5868.2664666916635;5876.500497457679;5877.941220587825;5880.176775251468;4955.82654607087;4963.379577552806;4965.577925876269;4969.875753106129;4975.577075948512;3088.6448058473115;3127.358891427252;3129.702678245563;3161.8893338733033;3164.7151756341577;5551.528120109755;5559.861003474864;5566.805161819398;5568.582356323292;5568.972155139199;6014.0678194879865;6020.729067191987;6022.277326720734;6022.5784195105925;6028.547858910511;5534.1975413564805;5539.584531160179;5541.445855414427;5541.750621221974;5546.306711661043;5681.488666020078;5836.474717275466;5848.4151584841175;5858.091995740667;5860.09168578871;5516.255305533701;5672.376038635664;5679.261695979496;5680.744366503434;5682.06245969427;5480.506754392124;5517.034518959246;5610.354809196994;5621.269234999424;5630.042892708331;3975.363941769303;3989.4215338775134;3993.281209382223;4000;4002.9799851000557;5699.202111704448;5877.471027607536;5883.882322353444;5891.293044834647;5892.145638882424;5652.3217213934595;5655.349634791887;5657.60396772222;5657.688827114548;5659.236003139524;5597.356304025089;5610.0182468067105;5621.156826476062;5630.634008789416;5633.577481688808;5371.481679499934;5526.723663816873;5535.446455354432;5551.444855514416;5555.8888822222525;5703.429657034263;5704.401037890962;5704.429557044428;5707.229524014371;5708.286464191976;5556.666600004012;5560.777568897361;5564.054110801255;5564.610477266552;5576.275084239023 06:38:38 INFO - 2015-11-19 06:38:38,750 DEBUG : BROWSER_OUTPUT: |5;yui.html;590.4508806809667;643.5977514053719;676.9000374391612;681.8943063825108;691.2810676896029;11847.407629618529;12074.577389791359;12171;12178;12183.51265949361;13067.673308167301;13271.867281327184;13274.070815042951;13283.800742988862;13297.601071967832;589.5696141816477;763.8701420758457;775.1512094256808;775.1783109903492;775.8021704465353;596.3589141672697;752.6575408189261;765.6324964017275;766.84279722657;767.3592550220573;793.6587267474983;807.5518087461456;807.8182408957996;807.9151689072651;808.6159074439623;618.505195843328;628.0328294426578;796.3907610677836;803.1245941923303;804.2319584796535;594.5214102647367;594.5243804956061;595.9612625179393;596.385722705614;596.5436441122545;11408.657740267805;11435.542578296858;11563.42182890852;11564.42177891102;11572.074234061254;8995;9229.53852307382;9371.531423428802;9711.320207585472;9830.262730295257;8862.911370886273;9023.684171053981;9059.7282081537;9261.814763704755;9273.67542136022;2887.3647797484728;2940.588317635533;2945.234239097829;2972.212363723615;2988.342564635777;39452.80273598614;39501.80249098765;39780.801095994335;39922;40052.198956020715;6219.813405597839;6428.774992875227;6546.672666366758;6633.701483433257;6650.434713049445;10182.23633227496;10184.134348580306;10187.694369168938;10193.592256309665;10212.08091271789;5358.981793459308;5443.210734443563;5531.25328080712;5597.916031259534;5606.495415412633;3488.4767284907466;3505.386557352453;3558.6619271169197;3583.6595523425235;3585.6055833858254;2399.7240317363376;2432.2581612608324;2432.914847980312;2432.927012189637;2433.5862903306124;378.4021246430633;378.7727363581829;387.7402140565828;389.84016553213615;393.1645253835599;453.29286313351275;547.5893080189858;560.1234068682498;560.123406868258;568.3123420661046;7716.884246736304;7728.22717728234;7729.343005844454;7819.491733037335;7973.401994850409;366.66450198069003;380.3211267886864;415.4142658851066;417.138608772883;509.95410413063;3596.0829988352803;3663.212409331953;3747.4004159334377;3750.156214851691;3752.2307926874923;47304.5269547307;50653.240201397006;51076.74461627742;51193;51310.48689513132;44029.119417612106;44114;44202.778986104866;44333.33499997503;44659.33011004837;39884;40905;41148.1770364597;41543.584564154575;42135;7671.846563068819;8049.6253605187785;8170.142135075969;8260.421770476249;8534.050250854365;33066.5040024395;33834.154146145556;35698.286034279685;36340.81829590835;37273.25453490969;39598.2080358397;39676.80161599174;39960.80019599883;40385.59614403819;41004.589954100076;10362;10384;10409.635662751767;10427.492379527066;10661.89338106609;10867.945660271964;10977.506012229309;11106.278091924321;11232.157588180755;11332.263402878787;11112.833307500232;11156.888431115585;11381.658550243506;11392.715182120513;11413.60052398162;10774.946125269324;10894.945525272324;10966.122710183006;11140.832887506856;11398.145139114433;10658.253922225369;10800.891991079989;10930.726731831768;11191.216614836883;11201.775964480828;8891.199792018491;9055.320850936074;9071.319651026331;9174.724758257264;9400.153986141007;9472.52637368115;9674.129328360481;9705.369151005161;9724.173445256949;9739.41563506192 06:38:38 INFO - 2015-11-19 06:38:38,750 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:38:38 INFO - 2015-11-19 06:38:38,750 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:38:38 INFO - 2015-11-19 06:38:38,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 06:38:38 INFO - 2015-11-19 06:38:38,751 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:38:38 INFO - 2015-11-19 06:38:38,751 DEBUG : BROWSER_OUTPUT: __startTimestamp1447943918740__endTimestamp 06:38:38 INFO - 2015-11-19 06:38:38,751 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4673.06 Median:4726.15 stddev:497.89 (10.5%) stddev-sans-first:472.73 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: Values: 2623.1 2707.7 2717.1 2719.6 2723.6 4392.3 4536.9 4644.9 4665.2 4726.1 4665.7 4713.5 4714.7 4786.7 4797.6 4254.0 4365.4 4380.3 4517.0 4545.5 4453.8 4472.2 4506.1 4527.9 4556.9 4154.3 4254.4 4263.9 4340.8 4363.0 4317.2 4331.2 4345.1 4346.2 4353.2 4080.5 4271.7 4290.5 4297.2 4340.8 4516.0 4537.0 4624.5 4650.2 4679.4 5059.9 5061.9 5066.4 5074.8 5106.5 4859.4 4986.0 5086.9 5089.7 5104.2 4548.7 4566.5 4637.8 4660.6 4709.5 5213.3 5214.7 5214.9 5233.9 5256.2 4751.1 4892.8 4985.8 4990.1 5012.2 4965.9 5092.0 5203.6 5211.6 5225.5 5110.2 5154.7 5156.6 5164.2 5196.0 4654.8 4772.0 5086.2 5125.4 5126.2 4154.3 4186.6 4219.6 4244.7 4259.3 3719.0 3762.3 3766.6 3767.2 3788.7 4208.5 4404.9 4421.3 4426.1 4465.0 4997.5 4999.2 5026.7 5088.1 5128.2 4385.8 4414.5 4419.9 4422.4 4456.9 4258.7 4561.3 4563.8 4566.1 4607.3 4672.8 4698.0 4729.6 4827.2 4859.8 5114.0 5182.2 5185.6 5188.6 5188.6 4914.7 4915.2 4918.2 4920.9 4926.4 4825.0 4913.1 4955.8 4958.0 5062.3 5173.9 5191.8 5192.6 5194.2 5197.6 4954.6 4960.7 4964.3 4971.4 5005.7 4562.3 4689.2 4691.5 4755.2 4877.5 4869.8 4892.1 4902.5 4916.1 4941.0 5025.7 5056.3 5058.7 5059.7 5092.5 4590.4 4668.2 4721.8 4725.0 4806.3 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38491.80 Median:33164.25 stddev:57294.10 (172.8%) stddev-sans-first:57384.05 06:38:38 INFO - 2015-11-19 06:38:38,752 DEBUG : BROWSER_OUTPUT: Values: 566.4 570.8 573.6 580.8 589.4 28369.9 36719.6 37404.8 37505.4 37628.6 40493.4 41052.4 41061.4 41100.2 41194.8 7004.9 7124.5 7955.8 8120.5 8124.0 10187.1 10455.3 10459.6 10460.3 10472.8 9968.2 10127.2 10133.9 10135.4 10138.2 9867.2 9952.3 9955.8 9958.4 9972.6 9890.6 10054.5 10072.9 10083.8 10089.0 38224.4 38364.4 38367.6 38370.8 38642.0 2838.6 2852.1 2905.2 3485.0 3676.6 28494.7 28847.0 28880.1 29410.0 29857.9 2918.3 2926.7 2954.2 3061.1 3070.9 218156.0 219577.0 219618.0 220048.0 220195.0 46180.5 47752.5 53915.0 54839.7 55549.2 49983.5 50329.7 50382.0 50570.7 50611.5 12106.3 12178.7 12196.1 12310.1 12313.3 8265.9 8518.1 9016.8 9312.5 9370.2 18893.4 19102.3 19133.8 19146.1 19160.7 7206.4 7342.2 7463.8 7487.2 7535.8 771.7 779.5 827.6 848.3 970.3 26999.7 27097.7 27299.5 27423.7 27457.9 917.8 919.7 962.4 1017.7 1094.8 13886.2 14128.2 14541.9 14706.3 14763.5 205473.0 208899.0 209435.0 209540.0 210064.0 42368.8 42712.6 42736.8 42795.6 42833.6 1110.6 1118.6 1124.7 1127.4 1132.4 25307.6 26156.6 26344.7 26446.0 26599.3 36306.0 39846.6 39940.8 40094.8 40116.0 163150.0 242688.0 251563.0 251903.0 252294.0 26031.1 26567.5 26568.5 26643.7 26668.0 34776.0 38228.2 38922.6 39875.4 40057.6 33393.3 33725.3 34292.3 34908.0 34952.8 32011.4 33618.5 34318.3 34376.3 34438.8 32572.0 33227.3 33258.0 33557.0 33763.0 27617.7 28295.6 30580.0 30997.0 31010.7 22153.9 22197.3 30419.5 32664.2 33101.2 06:38:38 INFO - 2015-11-19 06:38:38,753 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,753 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20130.19 Median:4541.65 stddev:55755.97 (1227.7%) stddev-sans-first:55892.51 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: Values: 304.4 310.3 311.2 311.7 312.2 12564.7 12935.1 16227.5 16770.4 16841.8 12844.5 12875.5 12915.8 13018.3 14967.9 4904.3 4959.7 4960.1 5109.6 5110.3 3522.5 3629.2 5004.5 5037.1 5038.5 5379.0 5521.3 5527.8 5553.7 5570.5 4531.2 4666.2 5534.4 5539.5 5540.8 4013.0 4019.4 4020.1 4022.7 4023.3 10856.1 10977.9 11081.3 11637.0 11650.3 1700.7 1726.5 1726.7 1742.1 1783.8 8495.6 8614.0 8943.0 8999.2 9006.8 1549.1 1588.5 1592.2 1603.5 1630.9 50955.5 51407.7 52240.2 52847.7 53105.7 6067.3 6097.0 6113.2 6125.4 6158.0 7144.8 7149.0 7157.4 7161.9 7163.0 4552.1 4557.3 4596.4 4614.6 4660.0 4489.3 4594.4 4623.8 4646.6 4650.5 2792.7 2795.4 2822.6 2827.3 2835.4 994.1 996.4 1002.9 1034.2 1055.5 353.3 386.4 397.8 399.9 406.3 9886.3 10462.3 10492.1 10739.9 10820.5 405.8 412.9 418.3 422.1 445.4 5424.7 5694.7 5725.7 5792.4 5831.8 312522.0 315441.0 317823.0 319305.0 415500.0 56676.7 62112.0 62640.7 69014.7 69872.0 451.1 459.7 462.6 463.9 465.5 9456.8 9476.1 9526.6 9677.3 9691.1 30149.8 30701.0 31995.2 32317.7 32459.2 37052.0 37992.6 40337.8 41195.4 42854.4 5967.6 6064.6 6155.8 6167.7 6171.3 9566.2 10809.1 10873.0 10874.0 11160.4 8147.1 8154.6 8744.3 8883.1 9050.7 8865.0 9133.6 9166.5 9227.9 9383.9 9170.2 9179.3 9216.8 9328.4 9423.6 13593.0 13964.5 14092.9 14160.1 14199.0 12601.6 12993.2 13248.9 14555.9 14938.5 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4733.62 Median:5922.54 stddev:2392.92 (40.4%) stddev-sans-first:2386.43 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: Values: 1389.2 1594.6 1635.7 1660.7 1673.6 5616.7 6497.3 6707.0 6711.7 6718.8 6604.8 6696.5 6699.7 6707.0 6709.2 1649.7 1677.8 1917.1 2001.7 2029.5 1950.9 1953.3 1968.5 1970.6 1971.1 1910.0 1929.5 1979.6 1982.2 1982.6 1921.2 1943.8 1964.6 1967.0 1967.8 1955.6 1957.1 1974.3 1976.6 1977.5 6690.9 6736.5 6749.0 6770.0 6772.5 3975.9 4059.5 4059.7 4063.3 4064.0 2250.6 2628.3 2815.8 2836.8 2840.5 751.4 805.9 853.6 862.7 864.7 8908.8 8999.6 9018.0 9021.5 9026.5 3672.4 3712.6 3770.4 3776.3 3804.0 7855.2 7872.2 7874.6 7877.8 7879.8 4117.7 4131.1 4137.0 4145.6 4147.2 3751.2 3767.1 3771.8 3777.6 3781.1 3230.1 3230.5 3263.4 3265.1 3268.6 1000.0 1007.5 1035.0 1038.6 1039.7 1112.4 1115.5 1132.8 1138.1 1150.9 6223.4 6246.0 6247.4 6277.6 6279.8 1060.3 1078.3 1087.5 1107.5 1112.0 4829.4 4858.2 4858.7 4864.1 4883.8 6594.4 6823.5 7633.8 7740.0 7812.9 7827.4 7932.0 7981.6 8005.2 8016.9 6445.8 6454.8 6529.5 6544.1 6556.7 6249.2 6270.3 6286.8 6297.6 6326.7 7188.5 7233.0 7251.2 7324.1 7333.0 6920.9 7136.9 7392.9 7535.3 7537.1 5881.0 5959.6 5961.3 5963.2 5964.3 6532.5 6590.3 6607.4 6611.3 6629.7 6220.6 6220.7 6276.5 6305.5 6363.7 6184.5 6190.7 6247.8 6259.2 6299.3 6099.3 6260.7 6282.5 6304.3 6325.7 5840.0 5865.7 5869.2 5879.0 5885.4 5719.7 5760.3 5763.3 5775.8 5776.7 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4657.23 Median:5331.09 stddev:1385.33 (26.0%) stddev-sans-first:1349.68 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: Values: 279.3 281.7 285.4 287.4 289.0 5184.3 5266.8 5341.9 5363.1 5425.3 4817.1 5275.1 5290.6 5320.2 5345.3 4138.6 4142.6 4142.6 4143.7 4151.3 3937.1 4033.1 4045.3 4131.0 4148.0 4074.3 4113.7 4114.2 4118.3 4120.2 4096.2 4103.4 4106.8 4109.1 4115.8 3575.9 3577.1 3580.1 3589.4 3593.8 5167.3 5170.4 5172.5 5174.7 5179.0 4740.0 4741.7 4759.0 4761.8 4763.0 5648.8 5652.9 5658.3 5658.3 5662.1 3913.3 3929.6 3930.9 3932.8 3934.5 5485.6 5915.9 5916.1 5918.1 5920.5 3706.9 3809.9 3910.5 3915.0 3918.8 3952.9 3979.5 3983.1 4026.4 4054.5 4521.2 4599.4 4614.8 4661.5 4670.8 5640.5 5647.4 5650.6 5651.6 5651.6 1419.0 1421.4 1424.5 1425.1 1426.2 964.1 966.2 966.4 976.2 978.1 4956.2 4971.6 4974.1 4974.9 4984.3 5866.4 5868.3 5876.5 5877.9 5880.2 4955.8 4963.4 4965.6 4969.9 4975.6 3088.6 3127.4 3129.7 3161.9 3164.7 5551.5 5559.9 5566.8 5568.6 5569.0 6014.1 6020.7 6022.3 6022.6 6028.5 5534.2 5539.6 5541.4 5541.8 5546.3 5681.5 5836.5 5848.4 5858.1 5860.1 5516.3 5672.4 5679.3 5680.7 5682.1 5480.5 5517.0 5610.4 5621.3 5630.0 3975.4 3989.4 3993.3 4000.0 4003.0 5699.2 5877.5 5883.9 5891.3 5892.1 5652.3 5655.3 5657.6 5657.7 5659.2 5597.4 5610.0 5621.2 5630.6 5633.6 5371.5 5526.7 5535.4 5551.4 5555.9 5703.4 5704.4 5704.4 5707.2 5708.3 5556.7 5560.8 5564.1 5564.6 5576.3 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2015-11-19 06:38:38,754 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12114.66 Median:20979.50 stddev:14070.27 (67.1%) stddev-sans-first:14083.12 06:38:38 INFO - 2015-11-19 06:38:38,756 DEBUG : BROWSER_OUTPUT: Values: 590.5 643.6 676.9 681.9 691.3 11847.4 12074.6 12171.0 12178.0 12183.5 13067.7 13271.9 13274.1 13283.8 13297.6 589.6 763.9 775.2 775.2 775.8 596.4 752.7 765.6 766.8 767.4 793.7 807.6 807.8 807.9 808.6 618.5 628.0 796.4 803.1 804.2 594.5 594.5 596.0 596.4 596.5 11408.7 11435.5 11563.4 11564.4 11572.1 8995.0 9229.5 9371.5 9711.3 9830.3 8862.9 9023.7 9059.7 9261.8 9273.7 2887.4 2940.6 2945.2 2972.2 2988.3 39452.8 39501.8 39780.8 39922.0 40052.2 6219.8 6428.8 6546.7 6633.7 6650.4 10182.2 10184.1 10187.7 10193.6 10212.1 5359.0 5443.2 5531.3 5597.9 5606.5 3488.5 3505.4 3558.7 3583.7 3585.6 2399.7 2432.3 2432.9 2432.9 2433.6 378.4 378.8 387.7 389.8 393.2 453.3 547.6 560.1 560.1 568.3 7716.9 7728.2 7729.3 7819.5 7973.4 366.7 380.3 415.4 417.1 510.0 3596.1 3663.2 3747.4 3750.2 3752.2 47304.5 50653.2 51076.7 51193.0 51310.5 44029.1 44114.0 44202.8 44333.3 44659.3 39884.0 40905.0 41148.2 41543.6 42135.0 7671.8 8049.6 8170.1 8260.4 8534.1 33066.5 33834.2 35698.3 36340.8 37273.3 39598.2 39676.8 39960.8 40385.6 41004.6 10362.0 10384.0 10409.6 10427.5 10661.9 10867.9 10977.5 11106.3 11232.2 11332.3 11112.8 11156.9 11381.7 11392.7 11413.6 10774.9 10894.9 10966.1 11140.8 11398.1 10658.3 10800.9 10930.7 11191.2 11201.8 8891.2 9055.3 9071.3 9174.7 9400.2 9472.5 9674.1 9705.4 9724.2 9739.4 06:38:38 INFO - 2015-11-19 06:38:38,756 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:38:38 INFO - 2015-11-19 06:38:38,756 DEBUG : BROWSER_OUTPUT: 06:38:39 INFO - 2015-11-19 06:38:39,478 INFO : Browser exited with error code: 0 06:38:39 INFO - 2015-11-19 06:38:39,499 INFO : Completed test dromaeo_css (00:18:37) 06:38:39 INFO - 2015-11-19 06:38:39,499 INFO : Starting test kraken 06:38:39 INFO - 2015-11-19 06:38:39,499 DEBUG : operating with platform_type : linux_ 06:38:39 INFO - 2015-11-19 06:38:39,499 INFO : Initialising browser for kraken test... 06:38:39 INFO - 2015-11-19 06:38:39,505 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GL0pK/profile http://localhost:38809/getInfo.html 06:38:43 INFO - 2015-11-19 06:38:43,344 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:38:43 INFO - 2015-11-19 06:38:43,345 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:38:43 INFO - 2015-11-19 06:38:43,345 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:38:43 INFO - 2015-11-19 06:38:43,345 DEBUG : BROWSER_OUTPUT: __metrics 06:38:43 INFO - 2015-11-19 06:38:43,482 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:44 INFO - 2015-11-19 06:38:44,090 DEBUG : BROWSER_OUTPUT: console.error: 06:38:44 INFO - 2015-11-19 06:38:44,094 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 06:38:44 INFO - 2015-11-19 06:38:44,094 DEBUG : BROWSER_OUTPUT: Stack: 06:38:44 INFO - 2015-11-19 06:38:44,094 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:38:44 INFO - 2015-11-19 06:38:44,094 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 06:38:44 INFO - 2015-11-19 06:38:44,095 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:38:44 INFO - 2015-11-19 06:38:44,096 DEBUG : BROWSER_OUTPUT: 06:38:44 INFO - 2015-11-19 06:38:44,674 INFO : Browser initialized. 06:38:44 INFO - 2015-11-19 06:38:44,675 INFO : Running cycle 1/1 for kraken test... 06:38:44 INFO - 2015-11-19 06:38:44,675 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GL0pK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:38:56 INFO - 2015-11-19 06:38:56,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 06:38:56 INFO - 2015-11-19 06:38:56,616 DEBUG : BROWSER_OUTPUT: 06:38:59 INFO - 2015-11-19 06:38:59,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38809/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:59 INFO - 2015-11-19 06:38:59,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 178638848 06:38:59 INFO - 2015-11-19 06:38:59,827 DEBUG : BROWSER_OUTPUT: 06:39:02 INFO - 2015-11-19 06:39:02,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38809/tests/kraken/driver.html?testName=audio-dft) 06:39:03 INFO - 2015-11-19 06:39:03,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 168628224 06:39:03 INFO - 2015-11-19 06:39:03,155 DEBUG : BROWSER_OUTPUT: 06:39:06 INFO - 2015-11-19 06:39:06,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38809/tests/kraken/driver.html?testName=audio-fft) 06:39:06 INFO - 2015-11-19 06:39:06,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 150827008 06:39:06 INFO - 2015-11-19 06:39:06,761 DEBUG : BROWSER_OUTPUT: 06:39:08 INFO - 2015-11-19 06:39:08,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38809/tests/kraken/driver.html?testName=audio-oscillator) 06:39:09 INFO - 2015-11-19 06:39:09,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 155541504 06:39:09 INFO - 2015-11-19 06:39:09,401 DEBUG : BROWSER_OUTPUT: 06:39:11 INFO - 2015-11-19 06:39:11,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:39:12 INFO - 2015-11-19 06:39:12,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 155009024 06:39:12 INFO - 2015-11-19 06:39:12,156 DEBUG : BROWSER_OUTPUT: 06:39:15 INFO - 2015-11-19 06:39:15,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38809/tests/kraken/driver.html?testName=imaging-darkroom) 06:39:15 INFO - 2015-11-19 06:39:15,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 156524544 06:39:15 INFO - 2015-11-19 06:39:15,735 DEBUG : BROWSER_OUTPUT: 06:39:19 INFO - 2015-11-19 06:39:19,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38809/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:19 INFO - 2015-11-19 06:39:19,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 156213248 06:39:19 INFO - 2015-11-19 06:39:19,725 DEBUG : BROWSER_OUTPUT: 06:39:22 INFO - 2015-11-19 06:39:22,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38809/tests/kraken/driver.html?testName=json-parse-financial) 06:39:23 INFO - 2015-11-19 06:39:23,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 157691904 06:39:23 INFO - 2015-11-19 06:39:23,145 DEBUG : BROWSER_OUTPUT: 06:39:24 INFO - 2015-11-19 06:39:24,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:39:25 INFO - 2015-11-19 06:39:25,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 165912576 06:39:25 INFO - 2015-11-19 06:39:25,500 DEBUG : BROWSER_OUTPUT: 06:39:27 INFO - 2015-11-19 06:39:27,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:39:28 INFO - 2015-11-19 06:39:28,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 167358464 06:39:28 INFO - 2015-11-19 06:39:28,010 DEBUG : BROWSER_OUTPUT: 06:39:30 INFO - 2015-11-19 06:39:30,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:39:30 INFO - 2015-11-19 06:39:30,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 174739456 06:39:30 INFO - 2015-11-19 06:39:30,729 DEBUG : BROWSER_OUTPUT: 06:39:33 INFO - 2015-11-19 06:39:33,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:39:33 INFO - 2015-11-19 06:39:33,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 181104640 06:39:33 INFO - 2015-11-19 06:39:33,896 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2015-11-19 06:39:36,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:39:37 INFO - 2015-11-19 06:39:37,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 179392512 06:39:37 INFO - 2015-11-19 06:39:37,174 DEBUG : BROWSER_OUTPUT: 06:39:38 INFO - 2015-11-19 06:39:38,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38809/tests/kraken/driver.html?testName=ai-astar) 06:39:39 INFO - 2015-11-19 06:39:39,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 237654016 06:39:39 INFO - 2015-11-19 06:39:39,187 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;116;114;117;124;113;113;112;113 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;163;168;132;160;161;138;169;139 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;161;162;162;162;163;162;162 06:39:39 INFO - 2015-11-19 06:39:39,188 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;73;82;90;73;73;75;122;90;73 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;132;92;92;91;127;92;92;128 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;109;109;109;109 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;148;148;147;148;148;147 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;72;89;71;72;72;80;72;70 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;69;71;71;71;70;69;70 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;87;84;83;84;85;85;85 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;128;119;139;132;132;131;132;121 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;145;165;153;152;146;157;157;154;144 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;73;71;69;69;70;69;71 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 06:39:39 INFO - 2015-11-19 06:39:39,189 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:39:39 INFO - 2015-11-19 06:39:39,190 DEBUG : BROWSER_OUTPUT: __startTimestamp1447943979188__endTimestamp 06:39:39 INFO - 2015-11-19 06:39:39,190 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:39:39 INFO - 2015-11-19 06:39:39,197 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:39:39 INFO - 2015-11-19 06:39:39,197 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:3.83 (3.3%) stddev-sans-first:4.06 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 116.0 114.0 117.0 124.0 113.0 113.0 112.0 113.0 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.50 Median:160.50 stddev:14.81 (9.2%) stddev-sans-first:15.70 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 163.0 168.0 132.0 160.0 161.0 138.0 169.0 139.0 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 162.0 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:15.39 (20.4%) stddev-sans-first:16.13 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: Values: 76.0 73.0 82.0 90.0 73.0 73.0 75.0 122.0 90.0 73.0 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:92.00 stddev:17.92 (19.5%) stddev-sans-first:18.63 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 132.0 92.0 92.0 91.0 127.0 92.0 92.0 128.0 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,198 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.20 Median:72.00 stddev:5.88 (8.2%) stddev-sans-first:6.22 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 72.0 89.0 71.0 72.0 72.0 80.0 72.0 70.0 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 69.0 71.0 71.0 71.0 70.0 69.0 70.0 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.12 06:39:39 INFO - 2015-11-19 06:39:39,199 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 87.0 84.0 83.0 84.0 85.0 85.0 85.0 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:131.50 stddev:5.81 (4.4%) stddev-sans-first:6.12 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 128.0 119.0 139.0 132.0 132.0 131.0 132.0 121.0 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:155.50 stddev:6.64 (4.3%) stddev-sans-first:6.80 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: Values: 158.0 145.0 165.0 153.0 152.0 146.0 157.0 157.0 154.0 144.0 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.37 (1.9%) stddev-sans-first:1.39 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 73.0 71.0 69.0 69.0 70.0 69.0 71.0 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:39:39 INFO - 2015-11-19 06:39:39,200 DEBUG : BROWSER_OUTPUT: 06:39:40 INFO - 2015-11-19 06:39:40,070 INFO : Browser exited with error code: 0 06:39:40 INFO - 2015-11-19 06:39:40,123 INFO : Completed test kraken (00:01:00) 06:39:40 INFO - 2015-11-19 06:39:40,123 INFO : Starting test v8_7 06:39:40 INFO - 2015-11-19 06:39:40,123 DEBUG : operating with platform_type : linux_ 06:39:40 INFO - 2015-11-19 06:39:40,123 INFO : Initialising browser for v8_7 test... 06:39:40 INFO - 2015-11-19 06:39:40,129 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUJMUT4/profile http://localhost:38809/getInfo.html 06:39:43 INFO - 2015-11-19 06:39:43,885 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:39:43 INFO - 2015-11-19 06:39:43,885 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:39:43 INFO - 2015-11-19 06:39:43,885 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:39:43 INFO - 2015-11-19 06:39:43,885 DEBUG : BROWSER_OUTPUT: __metrics 06:39:44 INFO - 2015-11-19 06:39:44,034 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:45 INFO - 2015-11-19 06:39:45,134 INFO : Browser initialized. 06:39:45 INFO - 2015-11-19 06:39:45,134 INFO : Running cycle 1/1 for v8_7 test... 06:39:45 INFO - 2015-11-19 06:39:45,135 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUJMUT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:39:57 INFO - 2015-11-19 06:39:57,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 06:39:57 INFO - 2015-11-19 06:39:57,008 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38809/tests/v8_7/run.html (next: http://localhost:38809/tests/v8_7/run.html) 06:40:18 INFO - 2015-11-19 06:40:18,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 435380224 06:40:18 INFO - 2015-11-19 06:40:18,659 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,659 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:40:18 INFO - 2015-11-19 06:40:18,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:40:18 INFO - 2015-11-19 06:40:18,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:40:18 INFO - 2015-11-19 06:40:18,660 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:40:18 INFO - 2015-11-19 06:40:18,660 DEBUG : BROWSER_OUTPUT: |0;Richards;163.26530612244898 06:40:18 INFO - 2015-11-19 06:40:18,660 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.52984212552946 06:40:18 INFO - 2015-11-19 06:40:18,661 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.04557033682426 06:40:18 INFO - 2015-11-19 06:40:18,661 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 06:40:18 INFO - 2015-11-19 06:40:18,661 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2004.0080160320642 06:40:18 INFO - 2015-11-19 06:40:18,661 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: |7;RegExp;26684.21052631579 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: |8;Splay;602.0408163265306 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: __startTimestamp1447944018657__endTimestamp 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:40:18 INFO - 2015-11-19 06:40:18,662 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.27 Median:163.27 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: Values: 163.3 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.53 Median:192.53 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: Values: 192.5 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: Values: 283.0 06:40:18 INFO - 2015-11-19 06:40:18,663 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: Values: 5050.5 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: Values: 2004.0 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: Values: 798.1 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: Values: 12268.3 06:40:18 INFO - 2015-11-19 06:40:18,664 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: Values: 26684.2 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.04 Median:602.04 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: Values: 602.0 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:40:18 INFO - 2015-11-19 06:40:18,665 DEBUG : BROWSER_OUTPUT: 06:40:19 INFO - 2015-11-19 06:40:19,630 INFO : Browser exited with error code: 0 06:40:19 INFO - 2015-11-19 06:40:19,647 INFO : Completed test v8_7 (00:00:39) 06:40:19 INFO - 2015-11-19 06:40:19,685 INFO : Completed test suite (00:20:17) 06:40:19 INFO - 2015-11-19 06:40:19,686 DEBUG : Working with test: dromaeo_css 06:40:19 INFO - 2015-11-19 06:40:19,686 DEBUG : Generating results file: dromaeo_css 06:40:19 INFO - 2015-11-19 06:40:19,687 DEBUG : Working with test: kraken 06:40:19 INFO - 2015-11-19 06:40:19,687 DEBUG : Generating results file: kraken 06:40:19 INFO - 2015-11-19 06:40:19,687 INFO : javascript benchmark 06:40:19 INFO - 2015-11-19 06:40:19,687 DEBUG : Working with test: v8_7 06:40:19 INFO - 2015-11-19 06:40:19,688 DEBUG : Generating results file: v8_7 06:40:19 INFO - 2015-11-19 06:40:19,688 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:40:19 INFO - 2015-11-19 06:40:19,762 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 06:40:19 INFO - 2015-11-19 06:40:19,762 DEBUG : process_Request line: dromaeo_css 5948.23 graph.html#tests=[[72,132,35]] 06:40:19 INFO - 2015-11-19 06:40:19,763 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:40:19 INFO - 2015-11-19 06:40:19,793 DEBUG : process_Request line: kraken 1547.40 graph.html#tests=[[232,132,35]] 06:40:19 INFO - 2015-11-19 06:40:19,793 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:40:19 INFO - 2015-11-19 06:40:19,922 DEBUG : process_Request line: v8_7 19762.33 graph.html#tests=[[230,132,35]] 06:40:19 INFO - 2015-11-19 06:40:19,923 INFO : javascript benchmark 06:40:19 INFO - 2015-11-19 06:40:19,927 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.055699948019, 2707.6750789905213, 2717.076194094008, 2719.578465337873, 2723.645926029617, 4392.341148827678, 4536.886577835556, 4644.883877903054, 4665.2069148244755, 4726.149293127236, 4665.696729712575, 4713.505081966396, 4714.693544919578, 4786.736729479886, 4797.6401769867225, 4253.957460425395, 4365.43249377582, 4380.299152135659, 4517.0, 4545.52272011439, 4453.799579018936, 4472.150291444631, 4506.076254367863, 4527.886802829923, 4556.906342477814, 4154.293770059082, 4254.425652536899, 4263.850765223233, 4340.826366945318, 4363.040131171138, 4317.201317756225, 4331.155424692186, 4345.087531618364, 4346.15250026245, 4353.238183317907, 4080.5307389650275, 4271.722338048017, 4290.485141783006, 4297.247981603207, 4340.826366945318, 4515.977420112911, 4536.977315113436, 4624.468186158568, 4650.232711602582, 4679.368285281512, 5059.949400505985, 5061.898762024775, 5066.442691303953, 5074.847754567369, 5106.4638212987475, 4859.441164266084, 4985.950140498585, 5086.872828179326, 5089.694618322913, 5104.183330667112, 4548.681592288541, 4566.45202575693, 4637.791299391535, 4660.603848672833, 4709.505501922317, 5213.2701421800975, 5214.687118772886, 5214.895702085937, 5233.947660523346, 5256.2115682647145, 4751.097291514601, 4892.804287828518, 4985.825496107619, 4990.051890140861, 5012.172991456368, 4965.925511117336, 5092.0, 5203.583713302926, 5211.635185537052, 5225.529702326809, 5110.233464980282, 5154.664946778447, 5156.639035267495, 5164.225366195101, 5196.012757576124, 4654.790534425959, 4772.0217355442055, 5086.21163719624, 5125.384953805493, 5126.179811230185, 4154.31453810124, 4186.644135248538, 4219.578042195817, 4244.724092934011, 4259.339802330644, 3718.9772812476244, 3762.3039737648623, 3766.60450652683, 3767.246550689873, 3788.734788564774, 4208.537060923296, 4404.933925991113, 4421.314696222091, 4426.092651006536, 4464.977675111603, 4997.525235102659, 4999.150144475448, 5026.673266237683, 5088.084144853888, 5128.205128205134, 4385.780710964439, 4414.514403415622, 4419.911601767946, 4422.425084738963, 4456.866294011184, 4258.723182993095, 4561.315802629566, 4563.771811409416, 4566.063956888896, 4607.3089036644105, 4672.836450724209, 4698.036902434924, 4729.574338309569, 4827.155247831685, 4859.781309840995, 5114.0, 5182.24857395683, 5185.559227465556, 5188.55897248723, 5188.610854185876, 4914.70511769295, 4915.238138088602, 4918.2376731606655, 4920.901581968412, 4926.3842019747535, 4825.0, 4913.06651736169, 4955.776990035529, 4957.975210123926, 5062.31658726082, 5173.870653233699, 5191.844244672666, 5192.610554208374, 5194.246834209094, 5197.610179236497, 4954.5540901319055, 4960.70235785854, 4964.329815475009, 4971.37857767779, 5005.674631148963, 4562.315652652129, 4689.179393606173, 4691.530846915418, 4755.239161734106, 4877.5366340197625, 4869.756512174448, 4892.119418504703, 4902.485239049991, 4916.139675556692, 4940.975295123501, 5025.723585202849, 5056.292119103255, 5058.721770302669, 5059.696418214919, 5092.541671249605, 4590.403247577793, 4668.229742092517, 4721.834735784231, 4724.976375118103, 4806.327114204084], "unit": "ms", "name": "dojo.html", "value": 4641.950548365687}, {"lowerIsBetter": false, "replicates": [566.4165909113613, 570.7945139749688, 573.5755540899736, 580.8199458167971, 589.3605438099662, 28369.858150709242, 36719.63280367196, 37404.812975935085, 37505.437418438676, 37628.623713762856, 40493.39259911104, 41052.38421423681, 41061.38407923884, 41100.177996440056, 41194.79402602983, 7004.894926576106, 7124.5012849100585, 7955.840883182347, 8120.512769233836, 8124.0, 10187.134093602053, 10455.268131230818, 10459.581616735322, 10460.320079194866, 10472.842907356397, 9968.152707019912, 10127.189824814033, 10133.94933025334, 10135.44255065971, 10138.239632027591, 9867.210623150131, 9952.253580981383, 9955.800883982352, 9958.4024958502, 9972.60109595619, 9890.604375824958, 10054.497275136215, 10072.899271007269, 10083.798324033478, 10089.041541053588, 38224.42663360052, 38364.42453363202, 38367.616323836686, 38370.80814595909, 38642.0, 2838.5884046813303, 2852.073076250227, 2905.2155917902046, 3485.0, 3676.6323367663285, 28494.71505284962, 28846.980711350214, 28880.133595992153, 29410.0, 29857.85071074631, 2918.299608094042, 2926.6926972667775, 2954.23189970607, 3061.11227743954, 3070.9385812283854, 218156.0, 219577.0, 219618.0, 220048.0, 220195.0, 46180.5381946183, 47752.522474775506, 53915.0, 54839.72580137074, 55549.16676249859, 49983.500164998615, 50329.74835125801, 50382.0, 50570.74714626403, 50611.48165554966, 12106.273623582612, 12178.695532611755, 12196.085293603015, 12310.138290319592, 12313.26120432777, 8265.917340826634, 8518.063013068557, 9016.774580635536, 9312.534373281444, 9370.203532699661, 18893.433197004113, 19102.33141840057, 19133.80866191348, 19146.138423770964, 19160.712589310893, 7206.423486121098, 7342.229065947999, 7463.843104318839, 7487.213842546563, 7535.849283014309, 771.6951804037486, 779.5283853268804, 827.5696637748338, 848.3394154224502, 970.257752819094, 26999.73000269972, 27097.729022709915, 27299.45401091967, 27423.725762742517, 27457.86271068632, 917.8230508676644, 919.7010971434311, 962.37926537383, 1017.6692574913183, 1094.8467214589964, 13886.166829990232, 14128.152310861382, 14541.927290363481, 14706.264686765619, 14763.483278085216, 205473.0, 208899.0, 209435.0, 209540.0, 210064.0, 42368.788156059636, 42712.57287427148, 42736.78631606822, 42795.57204427978, 42833.57166428358, 1110.5613282753268, 1118.6028959719345, 1124.668222874254, 1127.3912087472836, 1132.399828091113, 25307.620385693863, 26156.60765088563, 26344.736552634997, 26446.0, 26599.335016623965, 36306.0, 39846.60153398545, 39940.8002959995, 40094.799526002185, 40116.0, 163150.0, 242688.0, 251563.0, 251903.0, 252294.0, 26031.088911887993, 26567.468650627266, 26568.468630627667, 26643.7335626649, 26668.0, 34776.0, 38228.235435291695, 38922.6107738919, 39875.40186897257, 40057.599424005384, 33393.33213335768, 33725.32549349048, 34292.314153717285, 34908.0, 34952.82523587366, 32011.35977280488, 33618.49572256369, 34318.313633726684, 34376.312473750884, 34438.827805861816, 32572.0, 33227.33545329032, 33258.0, 33557.0, 33762.987110386726, 27617.723822761516, 28295.575566366933, 30580.0, 30997.0, 31010.689893101684, 22153.889230553745, 22197.334079977627, 30419.54370684486, 32664.183395414355, 33101.17247068843], "unit": "ms", "name": "ext.html", "value": 16894.170613573824}, {"lowerIsBetter": false, "replicates": [304.4109647831445, 310.3234947813765, 311.1753852291428, 311.6727436191999, 312.23813894098396, 12564.748705025893, 12935.094543381967, 16227.513174604766, 16770.413035543745, 16841.831581684193, 12844.486220551167, 12875.484980600788, 12915.806262906064, 13018.34908254586, 14967.92516037421, 4904.288878112671, 4959.70241785494, 4960.131976904046, 5109.616778741591, 5110.28456016158, 3522.5068490411236, 3629.1652919828457, 5004.549590536851, 5037.118504261758, 5038.496150384969, 5378.973105134469, 5521.254630624854, 5527.751251193706, 5553.694546799945, 5570.470805273492, 4531.229690952546, 4666.160091183586, 5534.391216966131, 5539.501444869961, 5540.833774986757, 4012.979935100335, 4019.417184508259, 4020.115574573589, 4022.658074063708, 4023.3160362738404, 10856.077233435168, 10977.945110274477, 11081.27971681838, 11637.0, 11650.300981941025, 1700.6598680263996, 1726.4906852478548, 1726.6891959447294, 1742.0505824325774, 1783.8126996665294, 8495.617697203641, 8614.0, 8943.0, 8999.19007289347, 9006.819863602692, 1549.0559348018278, 1588.5393235961558, 1592.2277695317762, 1603.5029140966337, 1630.9266083026291, 50955.49044509544, 51407.74296128533, 52240.21639675408, 52847.73576132133, 53105.7344713274, 6067.332593414721, 6096.969515152485, 6113.205283313141, 6125.356837531995, 6157.96921015392, 7144.785656430316, 7148.964255178691, 7157.427405807627, 7161.89257161143, 7162.997180394749, 4552.0668263006, 4557.339185818038, 4596.35651008859, 4614.630829533629, 4659.976700116477, 4489.34904438861, 4594.379758732528, 4623.838165664186, 4646.581807637329, 4650.488446270908, 2792.720727927191, 2795.3850152966315, 2822.647169103862, 2827.2649111231226, 2835.4470878178968, 994.125169850527, 996.4021587047713, 1002.9498525073863, 1034.1984961654778, 1055.472263868066, 353.32338571635546, 386.37021654702653, 397.80507551299655, 399.8860324807416, 406.315358620725, 9886.25853061009, 10462.319949203278, 10492.108170805413, 10739.892601074045, 10820.458977051116, 405.8376649340228, 412.8761371588511, 418.30978884839647, 422.1009250296848, 445.3809205204768, 5424.728763561885, 5694.743736531866, 5725.713714314267, 5792.449717276936, 5831.7667293307795, 312522.0, 315441.0, 317823.0, 319305.0, 415500.0, 56676.71661641748, 62112.0, 62640.68679656664, 69014.65492672606, 69872.0, 451.07754641757685, 459.6920063557425, 462.6345187301994, 463.88866671998477, 465.5367908930636, 9456.810863782823, 9476.147146756824, 9526.571304291461, 9677.274204434836, 9691.07934746198, 30149.849250753607, 30701.0, 31995.200119996254, 32317.676823231468, 32459.18852028718, 37052.0, 37992.62007380001, 40337.79831100826, 41195.38206926958, 42854.35718464288, 5967.582269241111, 6064.575479716377, 6155.846103847261, 6167.722452489738, 6171.321154672893, 9566.186874115778, 10809.0812280957, 10873.0, 10874.0, 11160.404136644056, 8147.1038185798325, 8154.592270386338, 8744.344174186834, 8883.067277935723, 9050.728478145666, 8864.955675221583, 9133.588988495667, 9166.54167291646, 9227.86158207614, 9383.906160938302, 9170.220531254652, 9179.311551633788, 9216.769580760534, 9328.440293582407, 9423.57593908262, 13593.0, 13964.511242106477, 14092.859071409155, 14160.079594826304, 14199.0, 12601.621951341474, 12993.155444896052, 13248.933755331162, 14555.92722036383, 14938.477153299582], "unit": "ms", "name": "jquery.html", "value": 6311.931210671468}, {"lowerIsBetter": false, "replicates": [1389.1734418021274, 1594.5535250129965, 1635.6973959817435, 1660.6844699507096, 1673.6150685342363, 5616.719164041797, 6497.317781632925, 6707.0, 6711.664416779166, 6718.79843604692, 6604.801855944317, 6696.4642828573715, 6699.732010719566, 6707.0, 6709.228438729548, 1649.7442896351085, 1677.8406051425095, 1917.0702209428416, 2001.7497812773368, 2029.502771820906, 1950.882947023183, 1953.2870502266642, 1968.4980330015826, 1970.5566247594247, 1971.0637447212532, 1909.9809001910012, 1929.5465565592074, 1979.613975274822, 1982.2368388170587, 1982.6133903888747, 1921.164293532318, 1943.7570303712037, 1964.5776158126, 1966.9508262293414, 1967.803219678028, 1955.6186543623999, 1957.0801723190077, 1974.2793880233755, 1976.5651556657513, 1977.5352792093847, 6690.899636505456, 6736.46108311334, 6749.0, 6770.0, 6772.52592318533, 3975.920481590352, 4059.533153687334, 4059.6955228357697, 4063.2686116499017, 4064.04494943688, 2250.63989761639, 2628.303499572615, 2815.7888158388, 2836.8156069855395, 2840.5313123334627, 751.3538357012965, 805.9314958228557, 853.6116067189414, 862.7368652560966, 864.658459908339, 8908.821823563492, 8999.595018224196, 9017.954910225473, 9021.503817290046, 9026.458412495205, 3672.4491326300736, 3712.6101759315425, 3770.4155855842387, 3776.3013842439236, 3803.980980095082, 7855.175206603339, 7872.212778722196, 7874.606269686493, 7877.842443151105, 7879.803004924923, 4117.691173161965, 4131.091159944807, 4136.958630413717, 4145.564715704868, 4147.232761939051, 3751.212245428436, 3767.0770661188185, 3771.75483593571, 3777.56557995834, 3781.149241420713, 3230.07942736319, 3230.5154226866157, 3263.379957808009, 3265.069455205255, 3268.5587445695, 999.980000399988, 1007.4660429972126, 1034.9896501035043, 1038.5741845843168, 1039.7088815131776, 1112.449337577904, 1115.4645770030431, 1132.8130858408435, 1138.1009002887627, 1150.9366984815747, 6223.408776166257, 6246.0, 6247.375262473716, 6277.5605707600025, 6279.843003924939, 1060.2949038889053, 1078.3314345106085, 1087.5486673030603, 1107.4905543449943, 1111.955521779136, 4829.396325459317, 4858.222684370484, 4858.684185527929, 4864.124457597595, 4883.804647814048, 6594.439472644783, 6823.454123670094, 7633.847323053508, 7740.0, 7812.882806757903, 7827.373810095179, 7931.960340198262, 7981.600919953979, 8005.199480051948, 8016.879746803803, 6445.838854028593, 6454.774082907075, 6529.477641788645, 6544.051112588648, 6556.672166391661, 6249.187605611241, 6270.310265870842, 6286.774079054723, 6297.559170857996, 6326.683665816783, 7188.4968052235845, 7233.0, 7251.166115896739, 7324.121105467378, 7333.046703928455, 6920.9307906920285, 7136.928630713626, 7392.926070739224, 7535.321821036133, 7537.057867766529, 5881.0, 5959.642421454727, 5961.254843144607, 5963.224780778471, 5964.254468191476, 6532.477401807749, 6590.308017658077, 6607.438367738604, 6611.33886611335, 6629.668516574248, 6220.595661282002, 6220.657863817533, 6276.529260305404, 6305.464035557029, 6363.6818159090935, 6184.5052395809125, 6190.659513726789, 6247.812565623039, 6259.15354970294, 6299.338569450142, 6099.2985806632805, 6260.686965651608, 6282.465990390685, 6304.338044505261, 6325.715342809676, 5839.970800145972, 5865.73604187804, 5869.236999190078, 5878.970605146947, 5885.440883116097, 5719.656820590778, 5760.308762948473, 5763.250777399079, 5775.768969241183, 5776.7111644418455], "unit": "ms", "name": "mootools.html", "value": 3925.585883195967}, {"lowerIsBetter": false, "replicates": [279.33100224961214, 281.7281323522801, 285.3565210450434, 287.42228121475813, 288.98699558519866, 5184.300119483869, 5266.841994740154, 5341.946580534193, 5363.088274993251, 5425.321834770659, 4817.132916075105, 5275.050490911634, 5290.55030322423, 5320.228566857803, 5345.251664766926, 4138.606832350922, 4142.591518883579, 4142.606452387018, 4143.70994030418, 4151.335786274197, 3937.114149316395, 4033.144753413433, 4045.2516284487465, 4130.958690413103, 4148.004478925051, 4074.2666320062376, 4113.670906327501, 4114.177164567083, 4118.299889018859, 4120.237756015147, 4096.180763847243, 4103.384492326145, 4106.835726570934, 4109.075458021951, 4115.773632450214, 3575.8748443804343, 3577.105723569108, 3580.104973756561, 3589.407747721623, 3593.802340871251, 5167.302414174113, 5170.431252562215, 5172.456892026321, 5174.741262936838, 5179.04187725272, 4739.9526004739855, 4741.739204343759, 4759.048190361941, 4761.761911904391, 4763.023580166057, 5648.802291919763, 5652.9152062719095, 5658.321001479808, 5658.349289831681, 5662.065759149736, 3913.2760439318818, 3929.626685464876, 3930.941035884464, 3932.7640341579595, 3934.5475270343704, 5485.561155107622, 5915.940840591582, 5916.053431450947, 5918.053111502139, 5920.526357891358, 3706.9073273168387, 3809.923801523954, 3910.511186101737, 3915.0016745730227, 3918.8432462701744, 3952.8616498422416, 3979.5025621797276, 3983.103801644607, 4026.375911733686, 4054.4729185206324, 4521.231390663595, 4599.379083823641, 4614.76926153691, 4661.533846615379, 4670.8365207217585, 5640.464155905182, 5647.37878833328, 5650.604457688005, 5651.576131790132, 5651.632643878217, 1419.049237011205, 1421.3603878254826, 1424.4871846135384, 1425.0737020936474, 1426.172819764534, 964.0889359555293, 966.2077096780572, 966.4008314844841, 976.2385339435252, 978.1001478639527, 4956.207006878882, 4971.6271279654175, 4974.129527332775, 4974.90050198994, 4984.3021976923255, 5866.442687944638, 5868.2664666916635, 5876.500497457679, 5877.941220587825, 5880.176775251468, 4955.82654607087, 4963.379577552806, 4965.577925876269, 4969.875753106129, 4975.577075948512, 3088.6448058473115, 3127.358891427252, 3129.702678245563, 3161.8893338733033, 3164.7151756341577, 5551.528120109755, 5559.861003474864, 5566.805161819398, 5568.582356323292, 5568.972155139199, 6014.0678194879865, 6020.729067191987, 6022.277326720734, 6022.5784195105925, 6028.547858910511, 5534.1975413564805, 5539.584531160179, 5541.445855414427, 5541.750621221974, 5546.306711661043, 5681.488666020078, 5836.474717275466, 5848.4151584841175, 5858.091995740667, 5860.09168578871, 5516.255305533701, 5672.376038635664, 5679.261695979496, 5680.744366503434, 5682.06245969427, 5480.506754392124, 5517.034518959246, 5610.354809196994, 5621.269234999424, 5630.042892708331, 3975.363941769303, 3989.4215338775134, 3993.281209382223, 4000.0, 4002.9799851000557, 5699.202111704448, 5877.471027607536, 5883.882322353444, 5891.293044834647, 5892.145638882424, 5652.3217213934595, 5655.349634791887, 5657.60396772222, 5657.688827114548, 5659.236003139524, 5597.356304025089, 5610.0182468067105, 5621.156826476062, 5630.634008789416, 5633.577481688808, 5371.481679499934, 5526.723663816873, 5535.446455354432, 5551.444855514416, 5555.8888822222525, 5703.429657034263, 5704.401037890962, 5704.429557044428, 5707.229524014371, 5708.286464191976, 5556.666600004012, 5560.777568897361, 5564.054110801255, 5564.610477266552, 5576.275084239023], "unit": "ms", "name": "prototype.html", "value": 4204.606837526633}, {"lowerIsBetter": false, "replicates": [590.4508806809667, 643.5977514053719, 676.9000374391612, 681.8943063825108, 691.2810676896029, 11847.407629618529, 12074.577389791359, 12171.0, 12178.0, 12183.51265949361, 13067.673308167301, 13271.867281327184, 13274.070815042951, 13283.800742988862, 13297.601071967832, 589.5696141816477, 763.8701420758457, 775.1512094256808, 775.1783109903492, 775.8021704465353, 596.3589141672697, 752.6575408189261, 765.6324964017275, 766.84279722657, 767.3592550220573, 793.6587267474983, 807.5518087461456, 807.8182408957996, 807.9151689072651, 808.6159074439623, 618.505195843328, 628.0328294426578, 796.3907610677836, 803.1245941923303, 804.2319584796535, 594.5214102647367, 594.5243804956061, 595.9612625179393, 596.385722705614, 596.5436441122545, 11408.657740267805, 11435.542578296858, 11563.42182890852, 11564.42177891102, 11572.074234061254, 8995.0, 9229.53852307382, 9371.531423428802, 9711.320207585472, 9830.262730295257, 8862.911370886273, 9023.684171053981, 9059.7282081537, 9261.814763704755, 9273.67542136022, 2887.3647797484728, 2940.588317635533, 2945.234239097829, 2972.212363723615, 2988.342564635777, 39452.80273598614, 39501.80249098765, 39780.801095994335, 39922.0, 40052.198956020715, 6219.813405597839, 6428.774992875227, 6546.672666366758, 6633.701483433257, 6650.434713049445, 10182.23633227496, 10184.134348580306, 10187.694369168938, 10193.592256309665, 10212.08091271789, 5358.981793459308, 5443.210734443563, 5531.25328080712, 5597.916031259534, 5606.495415412633, 3488.4767284907466, 3505.386557352453, 3558.6619271169197, 3583.6595523425235, 3585.6055833858254, 2399.7240317363376, 2432.2581612608324, 2432.914847980312, 2432.927012189637, 2433.5862903306124, 378.4021246430633, 378.7727363581829, 387.7402140565828, 389.84016553213615, 393.1645253835599, 453.29286313351275, 547.5893080189858, 560.1234068682498, 560.123406868258, 568.3123420661046, 7716.884246736304, 7728.22717728234, 7729.343005844454, 7819.491733037335, 7973.401994850409, 366.66450198069003, 380.3211267886864, 415.4142658851066, 417.138608772883, 509.95410413063, 3596.0829988352803, 3663.212409331953, 3747.4004159334377, 3750.156214851691, 3752.2307926874923, 47304.5269547307, 50653.240201397006, 51076.74461627742, 51193.0, 51310.48689513132, 44029.119417612106, 44114.0, 44202.778986104866, 44333.33499997503, 44659.33011004837, 39884.0, 40905.0, 41148.1770364597, 41543.584564154575, 42135.0, 7671.846563068819, 8049.6253605187785, 8170.142135075969, 8260.421770476249, 8534.050250854365, 33066.5040024395, 33834.154146145556, 35698.286034279685, 36340.81829590835, 37273.25453490969, 39598.2080358397, 39676.80161599174, 39960.80019599883, 40385.59614403819, 41004.589954100076, 10362.0, 10384.0, 10409.635662751767, 10427.492379527066, 10661.89338106609, 10867.945660271964, 10977.506012229309, 11106.278091924321, 11232.157588180755, 11332.263402878787, 11112.833307500232, 11156.888431115585, 11381.658550243506, 11392.715182120513, 11413.60052398162, 10774.946125269324, 10894.945525272324, 10966.122710183006, 11140.832887506856, 11398.145139114433, 10658.253922225369, 10800.891991079989, 10930.726731831768, 11191.216614836883, 11201.775964480828, 8891.199792018491, 9055.320850936074, 9071.319651026331, 9174.724758257264, 9400.153986141007, 9472.52637368115, 9674.129328360481, 9705.369151005161, 9724.173445256949, 9739.41563506192], "unit": "ms", "name": "yui.html", "value": 5420.678561296308}], "name": "dromaeo_css", "value": 5948.231547721257}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 114.0, 117.0, 124.0, 113.0, 113.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 163.0, 168.0, 132.0, 160.0, 161.0, 138.0, 169.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 82.0, 90.0, 73.0, 73.0, 75.0, 122.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 132.0, 92.0, 92.0, 91.0, 127.0, 92.0, 92.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 103.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 89.0, 71.0, 72.0, 72.0, 80.0, 72.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 74.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 71.0, 71.0, 71.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 87.0, 84.0, 83.0, 84.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 128.0, 119.0, 139.0, 132.0, 132.0, 131.0, 132.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [158.0, 145.0, 165.0, 153.0, 152.0, 146.0, 157.0, 157.0, 154.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 73.0, 71.0, 69.0, 69.0, 70.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1547.3999999999994}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.26530612244898], "unit": "score", "name": "Richards", "value": 216.22475000000003}, {"lowerIsBetter": false, "replicates": [192.52984212552946], "unit": "score", "name": "DeltaBlue", "value": 343.41689200000013}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [602.0408163265306], "unit": "score", "name": "Splay", "value": 135.35793220338985}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19762.326011357924}]} 06:40:19 INFO - RETURN: dromaeo_css: 5948.23 06:40:19 INFO - RETURN: kraken: 1547.40 06:40:19 INFO - RETURN: v8_7: 19762.33 06:40:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19762.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1547.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5948.23"}}} 06:40:20 INFO - Return code: 0 06:40:20 INFO - # TBPL SUCCESS # 06:40:20 INFO - Running post-action listener: _resource_record_post_action 06:40:20 INFO - Running post-run listener: _resource_record_post_run 06:40:21 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505995264; Read time: 252; Write time: 476700 06:40:21 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 167616512; Read time: 128; Write time: 243984 06:40:21 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 337997824; Read time: 124; Write time: 232708 06:40:21 INFO - Running post-run listener: _upload_blobber_files 06:40:21 INFO - Blob upload gear active. 06:40:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:40:21 INFO - Copying logs to upload dir... 06:40:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1302.068407 ========= master_lag: 14.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-19 06:40:33.116626) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:40:33.120536) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010021 build_url: 'https://queue.taskcluster.net/v1/task/luVvR2O3TdqjhU5muA8MUw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.44 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 06:40:33.574083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:40:33.574413) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1447941209.846541-50793451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 06:40:33.590422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 06:40:33.590779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 06:40:33.592238) ========= ========= Total master_lag: 14.69 =========