builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1447420162.61 results: success (0) buildid: 20151113044230 builduid: 0ddff291284e4029b614cb940f2395c5 revision: e68c0bbf6818f1e1128595d2012273f22770b352 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.609420) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.610007) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.610457) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.634111) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.634426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.672442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.672777) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.726650) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.727019) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.727454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.727763) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 05:09:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-11-13 05:09:22 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.922131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.922594) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.973860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:22.974251) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e68c0bbf6818f1e1128595d2012273f22770b352 --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 e68c0bbf6818f1e1128595d2012273f22770b352 --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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 05:09:23,080 truncating revision to first 12 chars 2015-11-13 05:09:23,081 Setting DEBUG logging. 2015-11-13 05:09:23,081 attempt 1/10 2015-11-13 05:09:23,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e68c0bbf6818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 05:09:23,345 unpacking tar archive at: fx-team-e68c0bbf6818/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:23.538464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:23.538765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:23.550299) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:23.550580) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 05:09:23.550999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-11-13 05:09:23.551317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:23 INFO - MultiFileLogger online at 20151113 05:09:23 in /builds/slave/test 05:09:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:09:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:23 INFO - {'append_to_log': False, 05:09:23 INFO - 'base_work_dir': '/builds/slave/test', 05:09:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:09:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:23 INFO - 'branch': 'Fx-Team-Non-PGO', 05:09:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:23 INFO - 'config_files': ('talos/linux_config.py',), 05:09:23 INFO - 'default_actions': ('clobber', 05:09:23 INFO - 'read-buildbot-config', 05:09:23 INFO - 'download-and-extract', 05:09:23 INFO - 'populate-webroot', 05:09:23 INFO - 'create-virtualenv', 05:09:23 INFO - 'install', 05:09:23 INFO - 'run-tests'), 05:09:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:23 INFO - 'download_minidump_stackwalk': True, 05:09:23 INFO - 'download_symbols': 'ondemand', 05:09:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:23 INFO - 'installer_path': 'installer.exe', 05:09:23 INFO - 'log_level': 'info', 05:09:23 INFO - 'log_name': 'talos', 05:09:23 INFO - 'log_to_console': True, 05:09:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:23 INFO - 'opt_config_files': (), 05:09:23 INFO - 'pip_index': False, 05:09:23 INFO - 'sps_profile': False, 05:09:23 INFO - 'sps_profile_interval': 0, 05:09:23 INFO - 'suite': 'dromaeojs-e10s', 05:09:23 INFO - 'system_bits': '64', 05:09:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:23 INFO - 'title': 'talos-linux64-ix-013', 05:09:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:23 INFO - 'use_talos_json': True, 05:09:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:23 INFO - 'work_dir': 'build'} 05:09:23 INFO - ##### 05:09:23 INFO - ##### Running clobber step. 05:09:23 INFO - ##### 05:09:23 INFO - Running pre-action listener: _resource_record_pre_action 05:09:23 INFO - Running main action method: clobber 05:09:23 INFO - rmtree: /builds/slave/test/build 05:09:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:24 INFO - Running post-action listener: _resource_record_post_action 05:09:24 INFO - ##### 05:09:24 INFO - ##### Running read-buildbot-config step. 05:09:24 INFO - ##### 05:09:24 INFO - Running pre-action listener: _resource_record_pre_action 05:09:24 INFO - Running main action method: read_buildbot_config 05:09:24 INFO - Using buildbot properties: 05:09:24 INFO - { 05:09:24 INFO - "properties": { 05:09:24 INFO - "buildnumber": 671, 05:09:24 INFO - "product": "firefox", 05:09:24 INFO - "script_repo_revision": "production", 05:09:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:09:24 INFO - "repository": "", 05:09:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:09:24 INFO - "buildid": "20151113044230", 05:09:24 INFO - "slavename": "talos-linux64-ix-013", 05:09:24 INFO - "pgo_build": "False", 05:09:24 INFO - "basedir": "/builds/slave/test", 05:09:24 INFO - "project": "", 05:09:24 INFO - "platform": "ubuntu64_hw", 05:09:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:09:24 INFO - "slavebuilddir": "test", 05:09:24 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:09:24 INFO - "branch": "fx-team", 05:09:24 INFO - "repo_path": "integration/fx-team", 05:09:24 INFO - "stage_platform": "linux64", 05:09:24 INFO - "builduid": "0ddff291284e4029b614cb940f2395c5", 05:09:24 INFO - "revision": "e68c0bbf6818f1e1128595d2012273f22770b352" 05:09:24 INFO - }, 05:09:24 INFO - "sourcestamp": { 05:09:24 INFO - "repository": "", 05:09:24 INFO - "hasPatch": false, 05:09:24 INFO - "project": "", 05:09:24 INFO - "branch": "fx-team-linux64-talos", 05:09:24 INFO - "changes": [ 05:09:24 INFO - { 05:09:24 INFO - "category": null, 05:09:24 INFO - "files": [ 05:09:24 INFO - { 05:09:24 INFO - "url": null, 05:09:24 INFO - "name": "https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:09:24 INFO - } 05:09:24 INFO - ], 05:09:24 INFO - "repository": "", 05:09:24 INFO - "rev": "e68c0bbf6818f1e1128595d2012273f22770b352", 05:09:24 INFO - "who": "cbook@mozilla.com", 05:09:24 INFO - "when": 1447420146, 05:09:24 INFO - "number": 6658213, 05:09:24 INFO - "comments": "Backed out changeset 01dac856fde0 (bug 1198196) for mulet problems", 05:09:24 INFO - "project": "", 05:09:24 INFO - "at": "Fri 13 Nov 2015 05:09:06", 05:09:24 INFO - "branch": "fx-team-linux64-talos", 05:09:24 INFO - "revlink": "", 05:09:24 INFO - "properties": [ 05:09:24 INFO - [ 05:09:24 INFO - "buildid", 05:09:24 INFO - "20151113044230", 05:09:24 INFO - "Change" 05:09:24 INFO - ], 05:09:24 INFO - [ 05:09:24 INFO - "builduid", 05:09:24 INFO - "0ddff291284e4029b614cb940f2395c5", 05:09:24 INFO - "Change" 05:09:24 INFO - ], 05:09:24 INFO - [ 05:09:24 INFO - "pgo_build", 05:09:24 INFO - "False", 05:09:24 INFO - "Change" 05:09:24 INFO - ] 05:09:24 INFO - ], 05:09:24 INFO - "revision": "e68c0bbf6818f1e1128595d2012273f22770b352" 05:09:24 INFO - } 05:09:24 INFO - ], 05:09:24 INFO - "revision": "e68c0bbf6818f1e1128595d2012273f22770b352" 05:09:24 INFO - } 05:09:24 INFO - } 05:09:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:09:24 INFO - Running post-action listener: _resource_record_post_action 05:09:24 INFO - ##### 05:09:24 INFO - ##### Running download-and-extract step. 05:09:24 INFO - ##### 05:09:24 INFO - Running pre-action listener: _resource_record_pre_action 05:09:24 INFO - Running main action method: download_and_extract 05:09:24 INFO - mkdir: /builds/slave/test/build/tests 05:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:09:24 INFO - https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/test_packages.json 05:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/test_packages.json 05:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:28 INFO - Downloaded 1302 bytes. 05:09:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:09:28 INFO - Using the following test package requirements: 05:09:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'jsshell-linux-x86_64.zip'], 05:09:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:09:28 INFO - https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:31 INFO - Downloaded 21257785 bytes. 05:09:31 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 05:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:31 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 05:09:32 INFO - Return code: 0 05:09:32 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 05:09: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')]} 05:09:32 INFO - https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:35 INFO - Downloaded 21257785 bytes. 05:09:35 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 05:09:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:09:35 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 05:09:36 INFO - Return code: 0 05:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:36 INFO - https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:37 INFO - Downloaded 11131693 bytes. 05:09:37 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 05:09:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:37 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 05:09:37 INFO - Return code: 0 05:09: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')]} 05:09:37 INFO - https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/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 05:09:38 INFO - Downloaded 55594261 bytes. 05:09:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:09:40 INFO - mkdir: /builds/slave/test/properties 05:09:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:40 INFO - Contents: 05:09:40 INFO - build_url:https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - Running post-action listener: set_extra_try_arguments 05:09:40 INFO - ##### 05:09:40 INFO - ##### Running populate-webroot step. 05:09:40 INFO - ##### 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: populate_webroot 05:09:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:09:40 INFO - '../fennec_ids.txt'], 05:09:40 INFO - 'tests': ['tcheck2']}, 05:09:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:40 INFO - '--tppagecycles', 05:09:40 INFO - '7'], 05:09:40 INFO - 'tests': ['tsvgm']}}, 05:09:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:09:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['damp', 'tps']}, 05:09:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['damp', 'tps']}, 05:09:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:09:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:40 INFO - 'other': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other_l64': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'svgr': {'tests': ['tsvgx', 05:09:40 INFO - 'tsvgr_opacity', 05:09:40 INFO - 'tart', 05:09:40 INFO - 'tscrollx', 05:09:40 INFO - 'cart']}, 05:09:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tsvgx', 05:09:40 INFO - 'tsvgr_opacity', 05:09:40 INFO - 'tart', 05:09:40 INFO - 'tscrollx', 05:09:40 INFO - 'cart']}, 05:09:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['tp5o']}, 05:09:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tp5o']}, 05:09:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--xperf_path', 05:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:40 INFO - 'tests': ['tp5n']}, 05:09:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s', 05:09:40 INFO - '--xperf_path', 05:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:40 INFO - 'tests': ['tp5n']}}, 05:09:40 INFO - 'talos.zip': {'path': '', 05:09:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - ##### 05:09:40 INFO - ##### Running create-virtualenv step. 05:09:40 INFO - ##### 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: create_virtualenv 05:09:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:40 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 05:09:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:40 INFO - Using real prefix '/usr' 05:09:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:42 INFO - Installing pip.................done. 05:09:42 INFO - Return code: 0 05:09:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:42 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')]} 05:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 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')]} 05:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:42 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 05:09:42 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 05:09:42 INFO - Using env: {'DISPLAY': ':0', 05:09:42 INFO - 'HOME': '/home/cltbld', 05:09:42 INFO - 'LANG': 'en_US.UTF-8', 05:09:42 INFO - 'LANGUAGE': 'en_US:en', 05:09:42 INFO - 'LOGNAME': 'cltbld', 05:09:42 INFO - 'MAIL': '/var/mail/cltbld', 05:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:42 INFO - 'MOZ_NO_REMOTE': '1', 05:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:42 INFO - 'NO_EM_RESTART': '1', 05:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:42 INFO - 'PWD': '/builds/slave/test', 05:09:42 INFO - 'SHELL': '/bin/bash', 05:09:42 INFO - 'SHLVL': '1', 05:09:42 INFO - 'TERM': 'linux', 05:09:42 INFO - 'TMOUT': '86400', 05:09:42 INFO - 'USER': 'cltbld', 05:09:42 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:42 INFO - '_': '/tools/buildbot/bin/python'} 05:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:43 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 05:09:43 INFO - Cleaning up... 05:09:43 INFO - Return code: 0 05:09:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', '--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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:43 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 05:09:43 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 05:09:43 INFO - Using env: {'DISPLAY': ':0', 05:09:43 INFO - 'HOME': '/home/cltbld', 05:09:43 INFO - 'LANG': 'en_US.UTF-8', 05:09:43 INFO - 'LANGUAGE': 'en_US:en', 05:09:43 INFO - 'LOGNAME': 'cltbld', 05:09:43 INFO - 'MAIL': '/var/mail/cltbld', 05:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:43 INFO - 'MOZ_NO_REMOTE': '1', 05:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:43 INFO - 'NO_EM_RESTART': '1', 05:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:43 INFO - 'PWD': '/builds/slave/test', 05:09:43 INFO - 'SHELL': '/bin/bash', 05:09:43 INFO - 'SHLVL': '1', 05:09:43 INFO - 'TERM': 'linux', 05:09:43 INFO - 'TMOUT': '86400', 05:09:43 INFO - 'USER': 'cltbld', 05:09:43 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:43 INFO - '_': '/tools/buildbot/bin/python'} 05:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:43 INFO - Downloading/unpacking psutil>=0.7.1 05:09:43 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 05:09:43 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 05:09:43 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 05:09:43 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 05:09:43 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 05:09:43 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 05:09:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:09:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:45 INFO - Installing collected packages: psutil 05:09:45 INFO - Running setup.py install for psutil 05:09:45 INFO - building 'psutil._psutil_linux' extension 05:09:45 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 05:09:45 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 05:09:45 INFO - building 'psutil._psutil_posix' extension 05:09:45 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 05:09:45 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 05:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:45 INFO - Successfully installed psutil 05:09:45 INFO - Cleaning up... 05:09:45 INFO - Return code: 0 05:09:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:45 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 05:09:45 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 05:09:45 INFO - Using env: {'DISPLAY': ':0', 05:09:45 INFO - 'HOME': '/home/cltbld', 05:09:45 INFO - 'LANG': 'en_US.UTF-8', 05:09:45 INFO - 'LANGUAGE': 'en_US:en', 05:09:45 INFO - 'LOGNAME': 'cltbld', 05:09:45 INFO - 'MAIL': '/var/mail/cltbld', 05:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:45 INFO - 'MOZ_NO_REMOTE': '1', 05:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:45 INFO - 'NO_EM_RESTART': '1', 05:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:45 INFO - 'PWD': '/builds/slave/test', 05:09:45 INFO - 'SHELL': '/bin/bash', 05:09:45 INFO - 'SHLVL': '1', 05:09:45 INFO - 'TERM': 'linux', 05:09:45 INFO - 'TMOUT': '86400', 05:09:45 INFO - 'USER': 'cltbld', 05:09:45 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:45 INFO - '_': '/tools/buildbot/bin/python'} 05:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:47 INFO - Installing collected packages: mozsystemmonitor 05:09:47 INFO - Running setup.py install for mozsystemmonitor 05:09:47 INFO - Successfully installed mozsystemmonitor 05:09:47 INFO - Cleaning up... 05:09:47 INFO - Return code: 0 05:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', '--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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:47 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 05:09:47 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 05:09:47 INFO - Using env: {'DISPLAY': ':0', 05:09:47 INFO - 'HOME': '/home/cltbld', 05:09:47 INFO - 'LANG': 'en_US.UTF-8', 05:09:47 INFO - 'LANGUAGE': 'en_US:en', 05:09:47 INFO - 'LOGNAME': 'cltbld', 05:09:47 INFO - 'MAIL': '/var/mail/cltbld', 05:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:47 INFO - 'MOZ_NO_REMOTE': '1', 05:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:47 INFO - 'NO_EM_RESTART': '1', 05:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:47 INFO - 'PWD': '/builds/slave/test', 05:09:47 INFO - 'SHELL': '/bin/bash', 05:09:47 INFO - 'SHLVL': '1', 05:09:47 INFO - 'TERM': 'linux', 05:09:47 INFO - 'TMOUT': '86400', 05:09:47 INFO - 'USER': 'cltbld', 05:09:47 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:47 INFO - '_': '/tools/buildbot/bin/python'} 05:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:47 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 05:09:47 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 05:09:47 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 05:09:47 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 05:09:47 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 05:09:47 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 05:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:50 INFO - Downloading docopt-0.6.1.tar.gz 05:09:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:50 INFO - Running setup.py install for blobuploader 05:09:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:50 INFO - Running setup.py install for requests 05:09:50 INFO - Running setup.py install for docopt 05:09:50 INFO - Successfully installed blobuploader requests docopt 05:09:50 INFO - Cleaning up... 05:09:50 INFO - Return code: 0 05:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:50 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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:50 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 05:09:50 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 05:09:50 INFO - Using env: {'DISPLAY': ':0', 05:09:50 INFO - 'HOME': '/home/cltbld', 05:09:50 INFO - 'LANG': 'en_US.UTF-8', 05:09:50 INFO - 'LANGUAGE': 'en_US:en', 05:09:50 INFO - 'LOGNAME': 'cltbld', 05:09:50 INFO - 'MAIL': '/var/mail/cltbld', 05:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:50 INFO - 'MOZ_NO_REMOTE': '1', 05:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:50 INFO - 'NO_EM_RESTART': '1', 05:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:50 INFO - 'PWD': '/builds/slave/test', 05:09:50 INFO - 'SHELL': '/bin/bash', 05:09:50 INFO - 'SHLVL': '1', 05:09:50 INFO - 'TERM': 'linux', 05:09:50 INFO - 'TMOUT': '86400', 05:09:50 INFO - 'USER': 'cltbld', 05:09:50 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:50 INFO - '_': '/tools/buildbot/bin/python'} 05:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:51 INFO - Running setup.py (path:/tmp/pip-rw9nUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:51 INFO - Running setup.py (path:/tmp/pip-vJdhbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:51 INFO - Running setup.py (path:/tmp/pip-tHVpbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:51 INFO - Running setup.py (path:/tmp/pip-36aNyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:51 INFO - Running setup.py (path:/tmp/pip-KGoG4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:51 INFO - Running setup.py (path:/tmp/pip-cKXhE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:51 INFO - Running setup.py (path:/tmp/pip-iu1L2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:51 INFO - Running setup.py (path:/tmp/pip-SFE3gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:51 INFO - Running setup.py (path:/tmp/pip-U6K8fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:51 INFO - Running setup.py (path:/tmp/pip-lKb5fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:51 INFO - Running setup.py (path:/tmp/pip-jl_NZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:51 INFO - Running setup.py (path:/tmp/pip-3RwZaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:51 INFO - Running setup.py (path:/tmp/pip-JH36Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:52 INFO - Running setup.py (path:/tmp/pip-O1wCSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:52 INFO - Running setup.py (path:/tmp/pip-4RmbSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:52 INFO - Running setup.py (path:/tmp/pip-GfxOMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:52 INFO - Running setup.py (path:/tmp/pip-rZsKj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:52 INFO - Running setup.py install for manifestparser 05:09:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:52 INFO - Running setup.py install for mozcrash 05:09:52 INFO - Running setup.py install for mozdebug 05:09:52 INFO - Running setup.py install for mozdevice 05:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:52 INFO - Running setup.py install for mozfile 05:09:52 INFO - Running setup.py install for mozhttpd 05:09:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:52 INFO - Running setup.py install for mozinfo 05:09:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozInstall 05:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozleak 05:09:53 INFO - Running setup.py install for mozlog 05:09:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for moznetwork 05:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozprocess 05:09:53 INFO - Running setup.py install for mozprofile 05:09:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozrunner 05:09:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozscreenshot 05:09:53 INFO - Running setup.py install for moztest 05:09:53 INFO - Running setup.py install for mozversion 05:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:54 INFO - Cleaning up... 05:09:54 INFO - Return code: 0 05:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:54 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')]} 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:54 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')]} 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:54 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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:09:54 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 05:09:54 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 05:09:54 INFO - Using env: {'DISPLAY': ':0', 05:09:54 INFO - 'HOME': '/home/cltbld', 05:09:54 INFO - 'LANG': 'en_US.UTF-8', 05:09:54 INFO - 'LANGUAGE': 'en_US:en', 05:09:54 INFO - 'LOGNAME': 'cltbld', 05:09:54 INFO - 'MAIL': '/var/mail/cltbld', 05:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:54 INFO - 'MOZ_NO_REMOTE': '1', 05:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:54 INFO - 'NO_EM_RESTART': '1', 05:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:54 INFO - 'PWD': '/builds/slave/test', 05:09:54 INFO - 'SHELL': '/bin/bash', 05:09:54 INFO - 'SHLVL': '1', 05:09:54 INFO - 'TERM': 'linux', 05:09:54 INFO - 'TMOUT': '86400', 05:09:54 INFO - 'USER': 'cltbld', 05:09:54 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:54 INFO - '_': '/tools/buildbot/bin/python'} 05:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:54 INFO - Running setup.py (path:/tmp/pip-wuhvMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:54 INFO - Running setup.py (path:/tmp/pip-LOZHxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:54 INFO - Running setup.py (path:/tmp/pip-YL6GoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:54 INFO - Running setup.py (path:/tmp/pip-kRe2yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:54 INFO - Running setup.py (path:/tmp/pip-MD4M_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:54 INFO - Running setup.py (path:/tmp/pip-JXWIku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:54 INFO - Running setup.py (path:/tmp/pip-RfFiQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:54 INFO - Running setup.py (path:/tmp/pip-COGFfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:54 INFO - Running setup.py (path:/tmp/pip-8Qx6p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:54 INFO - Running setup.py (path:/tmp/pip-iJCdSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:55 INFO - Running setup.py (path:/tmp/pip-pkmIzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:55 INFO - Running setup.py (path:/tmp/pip-dbRZh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:55 INFO - Running setup.py (path:/tmp/pip-Ipb7RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:55 INFO - Running setup.py (path:/tmp/pip-Zv9n1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:55 INFO - Running setup.py (path:/tmp/pip-hZJly9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:55 INFO - Running setup.py (path:/tmp/pip-Xi2FBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:55 INFO - Running setup.py (path:/tmp/pip-9lHYVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:55 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 05:09:55 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 05:09:55 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 05:09:55 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 05:09:55 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 05:09:55 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 05:09:57 INFO - Downloading blessings-1.5.1.tar.gz 05:09:57 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 05:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:57 INFO - Installing collected packages: blessings 05:09:57 INFO - Running setup.py install for blessings 05:09:57 INFO - Successfully installed blessings 05:09:57 INFO - Cleaning up... 05:10:00 INFO - Return code: 0 05:10:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:00 INFO - Reading from file tmpfile_stdout 05:10:00 INFO - Current package versions: 05:10:00 INFO - argparse == 1.2.1 05:10:00 INFO - blessings == 1.5.1 05:10:00 INFO - blobuploader == 1.2.4 05:10:00 INFO - docopt == 0.6.1 05:10:00 INFO - manifestparser == 1.1 05:10:00 INFO - mozInstall == 1.12 05:10:00 INFO - mozcrash == 0.16 05:10:00 INFO - mozdebug == 0.1 05:10:00 INFO - mozdevice == 0.47 05:10:00 INFO - mozfile == 1.2 05:10:00 INFO - mozhttpd == 0.7 05:10:00 INFO - mozinfo == 0.9 05:10:00 INFO - mozleak == 0.1 05:10:00 INFO - mozlog == 3.0 05:10:00 INFO - moznetwork == 0.27 05:10:00 INFO - mozprocess == 0.22 05:10:00 INFO - mozprofile == 0.27 05:10:00 INFO - mozrunner == 6.11 05:10:00 INFO - mozscreenshot == 0.1 05:10:00 INFO - mozsystemmonitor == 0.0 05:10:00 INFO - moztest == 0.7 05:10:00 INFO - mozversion == 1.4 05:10:00 INFO - psutil == 3.1.1 05:10:00 INFO - requests == 1.2.3 05:10:00 INFO - wsgiref == 0.1.2 05:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:00 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')]} 05:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:00 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')]} 05:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:00 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 0x7f28a84c2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26da6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, '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': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', '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 05:10:00 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 05:10:00 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 05:10:00 INFO - Using env: {'DISPLAY': ':0', 05:10:00 INFO - 'HOME': '/home/cltbld', 05:10:00 INFO - 'LANG': 'en_US.UTF-8', 05:10:00 INFO - 'LANGUAGE': 'en_US:en', 05:10:00 INFO - 'LOGNAME': 'cltbld', 05:10:00 INFO - 'MAIL': '/var/mail/cltbld', 05:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:00 INFO - 'MOZ_NO_REMOTE': '1', 05:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:00 INFO - 'NO_EM_RESTART': '1', 05:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:00 INFO - 'PWD': '/builds/slave/test', 05:10:00 INFO - 'SHELL': '/bin/bash', 05:10:00 INFO - 'SHLVL': '1', 05:10:00 INFO - 'TERM': 'linux', 05:10:00 INFO - 'TMOUT': '86400', 05:10:00 INFO - 'USER': 'cltbld', 05:10:00 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:00 INFO - '_': '/tools/buildbot/bin/python'} 05:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 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)) 05:10:01 INFO - Cleaning up... 05:10:01 INFO - Return code: 0 05:10:01 INFO - Running post-action listener: _resource_record_post_action 05:10:01 INFO - Running post-action listener: _start_resource_monitoring 05:10:01 INFO - Starting resource monitoring. 05:10:01 INFO - ##### 05:10:01 INFO - ##### Running install step. 05:10:01 INFO - ##### 05:10:01 INFO - Running pre-action listener: _resource_record_pre_action 05:10:01 INFO - Running main action method: install 05:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:01 INFO - Reading from file tmpfile_stdout 05:10:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:01 INFO - Reading from file tmpfile_stdout 05:10:01 INFO - Output received: 05:10:01 INFO - Usage: mozinstall [options] installer 05:10:01 INFO - Options: 05:10:01 INFO - -h, --help show this help message and exit 05:10:01 INFO - -d DEST, --destination=DEST 05:10:01 INFO - Directory to install application into. [default: 05:10:01 INFO - "/builds/slave/test"] 05:10:01 INFO - --app=APP Application being installed. [default: firefox] 05:10:01 INFO - mkdir: /builds/slave/test/build/application 05:10:01 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'] 05:10:01 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 05:10:26 INFO - Reading from file tmpfile_stdout 05:10:26 INFO - Output received: 05:10:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:26 INFO - Running post-action listener: _resource_record_post_action 05:10:26 INFO - ##### 05:10:26 INFO - ##### Running run-tests step. 05:10:26 INFO - ##### 05:10:26 INFO - Running pre-action listener: _resource_record_pre_action 05:10:26 INFO - Running main action method: run_tests 05:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:26 INFO - Python 2.7.3 05:10:26 INFO - Return code: 0 05:10:26 INFO - grabbing minidump binary from tooltool 05:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:10:26 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 0x281aac0>, '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 0x281b9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281be50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:26 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 05:10:26 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 05:10:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:26 INFO - Return code: 0 05:10:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test/build 05:10:26 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 05:10:26 INFO - Using env: {'DISPLAY': ':0', 05:10:26 INFO - 'HOME': '/home/cltbld', 05:10:26 INFO - 'LANG': 'en_US.UTF-8', 05:10:26 INFO - 'LANGUAGE': 'en_US:en', 05:10:26 INFO - 'LOGNAME': 'cltbld', 05:10:26 INFO - 'MAIL': '/var/mail/cltbld', 05:10:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:26 INFO - 'MOZ_NO_REMOTE': '1', 05:10:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:26 INFO - 'NO_EM_RESTART': '1', 05:10:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:26 INFO - 'PWD': '/builds/slave/test', 05:10:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:26 INFO - 'SHELL': '/bin/bash', 05:10:26 INFO - 'SHLVL': '1', 05:10:26 INFO - 'TERM': 'linux', 05:10:26 INFO - 'TMOUT': '86400', 05:10:26 INFO - 'USER': 'cltbld', 05:10:26 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769', 05:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:26 INFO - '_': '/tools/buildbot/bin/python'} 05:10:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 05:10:27 INFO - mozversion INFO | application_buildid: 20151113044230 05:10:27 INFO - mozversion INFO | application_changeset: e68c0bbf6818f1e1128595d2012273f22770b352 05:10:27 INFO - mozversion INFO | application_display_name: Nightly 05:10:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:27 INFO - mozversion INFO | application_name: Firefox 05:10:27 INFO - mozversion INFO | application_remotingname: firefox 05:10:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:10:27 INFO - mozversion INFO | application_vendor: Mozilla 05:10:27 INFO - mozversion INFO | application_version: 45.0a1 05:10:27 INFO - mozversion INFO | platform_buildid: 20151113044230 05:10:27 INFO - mozversion INFO | platform_changeset: e68c0bbf6818f1e1128595d2012273f22770b352 05:10:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:27 INFO - mozversion INFO | platform_version: 45.0a1 05:10:27 INFO - 2015-11-13 05:10:27,166 DEBUG : using testdate: 1447420227 05:10:27 INFO - 2015-11-13 05:10:27,166 DEBUG : actual date: 1447420227 05:10:27 INFO - 2015-11-13 05:10:27,173 INFO : starting webserver on 'localhost:58360' 05:10:27 INFO - 2015-11-13 05:10:27,174 INFO : Starting test suite talos-linux64-ix-013.e 05:10:27 INFO - 2015-11-13 05:10:27,174 INFO : Starting test dromaeo_css 05:10:27 INFO - 2015-11-13 05:10:27,174 DEBUG : operating with platform_type : linux_ 05:10:27 INFO - 2015-11-13 05:10:27,174 INFO : Initialising browser for dromaeo_css test... 05:10:27 INFO - 2015-11-13 05:10:27,181 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrPiJo/profile http://localhost:58360/getInfo.html 05:11:38 INFO - 2015-11-13 05:11:38,070 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:38 INFO - 2015-11-13 05:11:38,071 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:38 INFO - 2015-11-13 05:11:38,071 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:11:38 INFO - 2015-11-13 05:11:38,071 DEBUG : BROWSER_OUTPUT: __metrics 05:11:43 INFO - 2015-11-13 05:11:43,549 INFO : Browser initialized. 05:11:43 INFO - 2015-11-13 05:11:43,549 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:43 INFO - 2015-11-13 05:11:43,550 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrPiJo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:55 INFO - 2015-11-13 05:11:55,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 140214272 05:11:55 INFO - 2015-11-13 05:11:55,671 DEBUG : BROWSER_OUTPUT: 05:12:45 INFO - 2015-11-13 05:12:45,342 DEBUG : BROWSER_OUTPUT: 1447420365339 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] 05:14:57 INFO - 2015-11-13 05:14:57,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58360/tests/dromaeo/cssquery-ext.html) 05:14:58 INFO - 2015-11-13 05:14:58,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 146534400 05:14:58 INFO - 2015-11-13 05:14:58,126 DEBUG : BROWSER_OUTPUT: 05:18:00 INFO - 2015-11-13 05:18:00,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-ext.html (next: http://localhost:58360/tests/dromaeo/cssquery-jquery.html) 05:18:00 INFO - 2015-11-13 05:18:00,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 05:18:00 INFO - 2015-11-13 05:18:00,814 DEBUG : BROWSER_OUTPUT: 05:21:02 INFO - 2015-11-13 05:21:02,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58360/tests/dromaeo/cssquery-mootools.html) 05:21:03 INFO - 2015-11-13 05:21:03,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 05:21:03 INFO - 2015-11-13 05:21:03,180 DEBUG : BROWSER_OUTPUT: 05:24:04 INFO - 2015-11-13 05:24:04,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58360/tests/dromaeo/cssquery-prototype.html) 05:24:05 INFO - 2015-11-13 05:24:05,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 05:24:05 INFO - 2015-11-13 05:24:05,518 DEBUG : BROWSER_OUTPUT: 05:27:08 INFO - 2015-11-13 05:27:08,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58360/tests/dromaeo/cssquery-yui.html) 05:27:08 INFO - 2015-11-13 05:27:08,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 140083200 05:27:08 INFO - 2015-11-13 05:27:08,810 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/dromaeo/cssquery-yui.html (next: http://localhost:58360/tests/dromaeo/cssquery-dojo.html) 05:30:11 INFO - 2015-11-13 05:30:11,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 143396864 05:30:11 INFO - 2015-11-13 05:30:11,364 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,365 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:11 INFO - 2015-11-13 05:30:11,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:11 INFO - 2015-11-13 05:30:11,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:11 INFO - 2015-11-13 05:30:11,366 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:11 INFO - 2015-11-13 05:30:11,369 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2668.8532130732806;2707.648005759251;2740.1368568900793;2744.4236710290825;2763.5854621806734;4730.4559975602815;4797.880052998672;4852.393450818648;4862.343583616215;4909.214525675892;4736.905261894769;4751.572358487735;4836.105320515707;4852.393450818648;4901.019796040789;4396.4284642996445;4462.620677242422;4466.151431228056;4529.230030894756;4569.200389931765;4536.251518499444;4599.655025873056;4601.608863246612;4609.354690343338;4629.837955671552;4288.69979101463;4340.110277393127;4373.671974601918;4412.823487060546;4508.413906192191;4461.866144015685;4465;4481.77591120446;4491.955080449186;4501.4598248210095;4430.623397011258;4438.178936896685;4446.510883802779;4450.10997800438;4469.843555475542;4619.214733495314;4690.976545117287;4715.7877895494785;4765.28520721891;4767.642426817968;5219.686818790885;5237.4500677428705;5248.107821670325;5248.580113590903;5267.104592219293;5279.498447647506;5286.365636123652;5287.101192797234;5289.947100528984;5295.814646487393;4644.210484217691;4731.834385796481;4744.383230180055;4751.287306903992;4761.333413322069;5365.7585408656705;5410.648307859977;5415.296011518556;5418.078926582491;5436.157395603688;5175.767090480937;5179.741012949337;5185.611079169077;5186.247994040843;5221.347331583552;5053.1157047516535;5054.064997975386;5168.250603662448;5254.395744489432;5273.894522109536;5160.354955630546;5169.53474187325;5185.688858668492;5195.090859099642;5202.843914682566;5139.614528910347;5147.948520514822;5149.150390185652;5154.9484505155215;5195.740212989411;4181.372794080851;4248.171606536695;4298.118885628502;4316.460442444694;4321.65426765858;3777.490038844776;3782.2813665403487;3783.735138540276;3785.37541305687;3814.6757525610633;4495.797689103998;4509.391232183679;4521.728696278234;4527.637788976874;4546.52261512543;5094.694318340911;5204.76578553966;5211.7915283389;5227.242049902743;5232.73836308183;4442.73343599385;4463;4557.15692596864;4557.498675145797;4573.5426457354;4609.631229501699;4626.86119416418;4628;4628.375169352162;4643.117807616542;4737.455192652751;4832.299316599144;4906.877328066756;4910.165271903785;4917.6311776616185;5133.050385678512;5244.711540865136;5249.711265880261;5285.788568457372;5295.12630415977;4877.146499362669;4885.7801398937845;4890.437599676083;4912.164931961646;4950.975245123751;4918.655694101379;5004.749762511933;5153.45888681683;5169.793208271627;5180.7409629517615;5102.821401251087;5187.559057480156;5191.844244672666;5216.9739151304;5252.737363131904;5027.924581131213;5044.747762611782;5062.873428164326;5063.721495317645;5104.3619547556555;4844.15227335222;4978.377702787152;5006.524380183877;5041.521055499722;5050.444451110448;4938.728369939688;4987.9750601248215;5009.474005229544;5024.824131155392;5044.369453818273;5086.720230387365;5103.642745007814;5104.183330667075;5135.306733590917;5158.3552055993005;4811.615070794258;4857.417109946829;4926.753662316798;4985.401751789664;4992.675476094042 05:30:11 INFO - 2015-11-13 05:30:11,369 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.2528649958075;560.9691466969315;567.7246535430313;579.5913880714097;585.7393459910339;27885.721142788567;28492.57261141082;36726.81636591817;37250.441243381305;37448.063798405055;39545.40681889774;40434.79782601083;40515;40579.39130913031;40665.593344066554;7881.802954926144;8048.154943730882;8066.7579972600915;8082;8103.716369927054;7779.688812447495;7893.565853878034;7894.131645518988;7935.325497332734;7947.08608510023;7943.165967573408;8014.3187829034605;8016.919830801705;8034.276915077642;8053.919460805376;7858.764237072897;7962.522248665098;7971.242731940456;7975;7978.082520510157;7720.691172353099;7867.173946735625;7905.644246008944;7930.881036784453;7947.523148611044;37037.07407314812;37315.44026839572;37579.62420375816;37612;37681;2802.66368035837;2824.378636699923;3167.7782555221143;3175.063356309894;3622.0763705255254;27082.187534374;27616.309592260153;27735.583966240523;28035.29911752202;28311.292217694518;3078.2612173078523;3096.4735994880925;3101.1316831287277;3106;3199.3281410903737;210760;211417;211569;211645;212128;51157;52050;53040.46959530433;53392.73303633457;53459.732701336245;56658.43341566614;56693.43306566882;56764.71617641968;56983;56994.43005569974;12947.223166609845;13102.541411050568;13137.146085504412;13137.73724525504;13147;9513.048695130432;9594.904050959542;9602.135807777333;9612.327137100336;9622.566984485575;18622.441326760218;18694.626107477776;18797.34209302668;18883;18973.525661858286;7558.357539609195;7774.922250777533;7797;7814.257645523666;7898.723544675909;799.6921185343568;902.8961669407971;923.7413524213231;931.469062634292;1015.6496008876926;22921.541569168858;23619.527609447716;25806.741932580808;26501.33746656349;26502.33744156373;940.3887473142512;949.6818565780403;963.2197919685077;978.1636700621009;1019.0370100255336;12552.937235313764;12622.116451848282;12725.68185795344;12737.299448530235;12805.167664101804;235568;244610;245113;245153;245174;43835.342469862975;44031.559684403386;44053.77973110114;44054.55945440569;44332.77833610812;1127.1771606727134;1190.2501424102759;1198.0894520164738;1203.1878482024774;1206.4631239098517;24205.74432888645;24238.757612424357;24598.508029838944;24638.13766518163;24708.76456177148;37822.243555128196;38105.61894381021;38224.617753823215;38400.80799595984;38483;232569;233249;234698;234790;235176;27581.862090689418;28465.857670711513;28655.283617909718;28910.27724306825;29066.854665726536;34495.482567762;34637.13407164841;35783;35930.8203458981;37447.2510549782;29818.55272170876;30526.236844079074;32902.506462402605;33014;33608.32783344271;32716.83641581777;32737.836310818293;32825.34349312953;33004.66995330112;33026.83486582552;32611.18472038218;33142.17144571405;33310.83344583261;33353.83323083369;33391.83304083464;26379.340516487242;26737.465250695266;29350.47219829836;29414.41171176607;30437.543436848908;22072;23852.16517421882;23969.76030239745;24051.398715032265;24156.39609009789 05:30:11 INFO - 2015-11-13 05:30:11,371 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.15936155930694;330.5058936889351;334.8426239667356;336.98652053917846;338.6055245638831;10777.353358798478;11111.833322500159;11127.72180695483;14668.413263469462;15183.39266429343;9030.277577793777;9156.404833685805;10278.434686092261;10475.68572942811;10493.422861742602;4235.343521754133;4373.300271956472;4373.387725718402;4388.539203383631;4388.780560971939;4307.698461107724;4346.782660866944;4352.325389564607;4510.030343476152;4582.587567118959;4491.6182124519455;4553.795079221426;4573.222552166123;4613.561711637389;4616.838410655628;4513.7066090704;4571.428571428572;4597.057603191354;4601.125786100647;4607.631389488833;4118.382242663594;4146.5853414658295;4149.854755083587;4159.958400416018;4161.438205842233;12013.099017573717;12020.879791202064;12064.155509114365;12116.636500904988;12297.508099676003;528.4662490884197;1726.067923321405;1752.1326943163087;1763.312308199803;1807.3854889337556;9208.447493150432;9369;9436.622535098588;9475.336726429152;9641.325107242426;1628.7149748793913;1664.1097013097935;1671.849533541975;1679.2359476438314;1689.408706952569;46603.5339646606;47027.29459058117;47162;52930.73534632341;55843.44156558464;6425.74297028123;6601.438877695354;6621.768238111643;6682.732690692415;6701.229358623723;7565.205653406423;7636.579988100708;7645.120811106683;7652.273034061755;7669.7315593953945;4917.557419832161;4918.803247870045;4937.580305673986;4942.950570494321;4960.851174464772;4919.729414882216;4925.75371231437;5028.823991160292;5066.771995260222;5099.770510327045;2960.3487232808748;2990.7607391408637;3016.8189908605555;3017.6680565137817;3027.6366835979825;1062.7661914378825;1080.524569189554;1086.163653986426;1088.2382332367374;1126.2631804714458;368.28368822640243;377.33400548032745;382.24315854608034;409.8852321350027;413.3881854854832;9099.545022748836;9326.114019168168;9349.252059835197;9415.576299066559;9864.309498335047;397.2908358579921;399.29325094582424;403.9434479172918;413.65046535677305;435.84527492740256;4981.252812078217;5023.447420783711;5091.541761241506;5720.342160651495;5887.411258874078;509347.2491069819;514704;531746;538088;538709;66821;68004;68574.1139768923;69023.65488172628;69733.3026669737;476.5568021739815;482.88652166740786;484.6922204400231;484.7551986246923;484.9515048495122;9692;9699.951500242454;9712.223022158068;9809.117179453884;9841.212702983601;31006;31742.36515269728;31971.520427194075;32120.518192226667;32564.417914029913;38776.612233878426;38852.80573597114;44235.55764442443;45030.324545131196;46313.76843115763;13359.933200333937;13428.328583570978;13533.86466135326;13874.306284685523;13970.79043814364;17804.55488612795;18080.547986300448;18238;18296.085195740427;18303.35938242155;8358.707445239388;8682.78293042679;14920.328585213474;15180.696386072437;15189.620259493158;8823.558822058743;9095.909040909506;9142.26861851037;9270.44377337362;9495.952520237632;8894.33292503052;9503.287253456157;9542.522873856418;9783.168430683472;9836.704898853046;14020.369083391475;14050.508232211823;14137.787933180805;14190.858091418953;14346.641333966734;14577.271136443347;14742.557723268319;14769.704605908037;15123.697526049198;15164.696706065597 05:30:11 INFO - 2015-11-13 05:30:11,371 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1481.237162861126;1637.8689704823612;1689.6113893804425;1716.6652502761963;1719.948401547954;6001.729922153502;6101.084837274411;6928.237893831681;7120.999999999994;7147.53541019834;6635.568688035274;6762.425193858516;6769.424598909086;6809.148856392951;6821.556598821086;2042.9387118386471;2085.092984551725;2085.6975738517904;2085.8122768950793;2089.028601700209;2056.1878058167017;2094.9476263093393;2102.127617038927;2109.92615258466;2115.3125234298836;2032.9390118296474;2034.7965203479607;2061.835053195741;2063.071617772001;2076.636588596997;2050.2004218354855;2070.254708305009;2082.6875968604754;2082.864613800106;2086.843486738501;2053.650879350514;2066.90698918549;2085.4577809769416;2090.153487837428;2093.5812837432572;6749.831254218684;6780.118584583973;6825.590464572092;6879.759208427731;6905.033295338657;4017.7790221537803;4044.8382064717375;4073.796310184479;4074.5110586729484;4109.630133288018;2643.1409791817546;2652.9469410611873;2686.7044625091225;2713.131797824697;2726.005008172003;878.5651102704138;896.6682327538853;901.3150005995425;909.2998391238775;941.9638397762475;8789.604467798901;8789.64841406343;8791.692290769792;8791.736247912573;8794.252488538483;3629.310431018098;3652.726045546595;3680.595134535199;3690.2988432197794;3702.1114932416026;7542.6605802739;7634.083909930733;7670.619288528007;7677.30904218623;7691.346235570039;3941.2708648900043;3945.506811648544;3975;3980.7014473914574;3991.960080399217;3609.801460919675;3636.054625797312;3700.8149592520267;3815.1225218199415;3833.21419109082;3151.7636177286336;3197.8560964756643;3227.064151396116;3228.6609905960004;3243.5296881951986;924.4545718026396;926.8748718922994;927.4064598656865;930.3952430919957;953.7329547726648;1181.3915833345834;1181.8936295733254;1193.087288224509;1196.8264601632713;1204.114975493012;6714.697838597275;6762.222344430454;6767.255601883789;6769.3907548320885;6775.4918381121615;420.18274456182434;424.96812739044697;428.1031239553131;434.2725934060436;434.35715141590623;5201.505856943584;5257.447967963309;5268.552173065333;5272.024675435056;5286.418493965661;8489.066202717697;8505.149485051445;8647.308215342757;8689.435186712843;8703.129687031245;8594.355423343275;8606.096359882247;8615.39692221551;8662.177093176138;8673.783155421164;6537.477001839841;6570.638614876132;6584;6647.335266473314;6854.143232095988;6259.467945224706;6261.5616906816085;6278.372162783685;6285.811425657238;6292.433680968735;7357.227491113356;7451.3666338361845;7668.6549105291515;7716.7684969451;7749.7287594933905;7452.664630091767;7704.614769261402;7750.844983100419;7890.9605451972375;7898.486598371088;5324.1747529133045;5422.783088676409;6163.537734669828;6228.252609686867;6246.063090536274;6620.834479137868;6767.898481522682;6772.492063095189;6804.285550017375;6813.0461735358085;6390;6392.93607063942;6516.315786842313;6517.315681853527;6522.184726909137;6313.684315784284;6316.273628532594;6367.90448143269;6451.516136289703;6508.772192973223;6537.542372033912;6548.410643042149;6561.475081993524;6569.4744420447205;6579.671016449254;5826.213461182856;6092.421219984094;6134.601250918855;6136.754529818757;6145.8156255312415;6187.288461826767;6206.72069756853;6209.720562574786;6210.347913469021;6226.50187984951 05:30:11 INFO - 2015-11-13 05:30:11,372 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.5897333466494;316.3309600195587;322.75309388317936;323.159252286574;323.5050372929419;5602.4117467665865;5672.914906276409;5695.8576035599135;5758.366579676237;5808.506276966463;5598.4961353478175;5667.489925906668;5677.48902598766;5688.089905615102;5710.885782284352;4199.2651286024975;4309.612134907866;4327.913441731163;4341.45731783527;4346.9565304347025;4291.420658211133;4342.392065110887;4343.6959412841115;4344.956550434503;4345.8478953236645;4291.527931927485;4292.613664770186;4300.161468513641;4301.37630043645;4303.655707543389;4290.69965102443;4292.270314046604;4294.656427485794;4299.376590394407;4309.956900430987;3647.1064589175558;3729.4778730977687;3733.1600389912323;3751.7748935063983;3753.8498460061564;5406.405295417501;5482.80810171646;5485.314335708036;5491.313585801775;5494.780208791683;4943.209086546171;4959.132151873408;4959.603231741452;4967.453580106186;4970.304157417964;5977.641341519523;5984.640921544721;5992.221011268551;5999.940000599981;6006.099085137221;3970.285348637244;4073.5111786585503;4081.632653061209;4083.2650122977852;4094.815733292009;6217.6891155442045;6237.781677641261;6276.623402595859;6282.246130464374;6282.371762823726;4176.895577610584;4184.456020717348;4185.97907010463;4187.644050255702;4189.036521600049;4256.893577660583;4259.488861336659;4261.744295342228;4264.317709166518;4269.231538323132;4792.976035119802;4798.73606951621;4854.17479028566;4912.705237685679;4924.76880779805;5904.084866845646;5908.881822363529;5917.142014407887;5938.881222375615;5939.82180534576;1496.4762333183298;1504.8194216694067;1511.1839606612525;1511.3350125944548;1512.7579587265984;991.712403403005;1009.2077718990557;1009.8030883977701;1017.4099022566893;1027.547878933267;5134.101532231844;5146.87132821675;5163.40620828602;5164;5168.689878607221;6146.078088286793;6167.599106058092;6170.321264660884;6183.288921774054;6192.938070619326;5130.640855140179;5131.974340128276;5141.820036298712;5142.30578871855;5142.691438513626;3293.226091868409;3332.8666853325594;3349.179451034512;3374.898753037413;3380.6619338066;5855.121731740188;5856.12158176277;5870.530357571384;5875.29496460419;5877.265341832271;6467.967660161669;6472.741090356333;6473.8705225896165;6478.574713563009;6483.4164925156965;5685.232493613309;5849.766009359578;5850.0932355484965;5854.736536855852;5871.706414679249;6291.119243306032;6292.150559674568;6293.118963345227;6301.023341382093;6314.147590075465;6116.480099191618;6119.602225855305;6128.754849805958;6129.816105516842;6140.140380346845;5698.8290351289525;5838.007538718513;5858.765649373977;5863.2670916135485;5869.002269614261;4182.644475219518;4214.072903961123;4218.789060547022;4220.092680073799;4222.155568886174;6088.8782224356155;6207.751689932352;6273.466755325666;6281.685915704288;6287.685615719287;6006.039033754579;6016.217891674054;6019.187409699634;6035.486983606267;6035.939640603713;5953.493953013869;5995.88008239824;5996.70016499182;6002.789902353396;6011.6393016417405;5692.345380281321;5854.619449735754;5874.530037596896;5891.469767720926;5900.29196496406;6014.36849130835;6038.426349496966;6050.818475445743;6058.818235452944;6076.8784624308155;5841.678707671119;5908.468237858613;5909.52723782105;5910.143029260647;5919.467247947533 05:30:11 INFO - 2015-11-13 05:30:11,373 DEBUG : BROWSER_OUTPUT: |5;yui.html;622.268834119909;664.810528999235;744.702119152339;750;759.0057224250332;11442.313461192334;11787.941060294697;11806;11840.644780656583;11858;11561.421928903543;12769.36153192339;12945.22328660281;12979.935100324508;12994.28531430771;757.6363345594118;764.1975925278449;773.941954353423;775.8874963130343;778.5756762564416;775.2170307988944;776.1074764021392;776.1462391369505;779.0573406178531;781.7732857471354;791.2285521616407;793.3573805217763;797.2585495489193;798.0582912163644;802.1377019703813;779.9259070388304;783.2793829676683;789.8578255913933;791.9485233459865;792.18405042806;578.7222133375961;579.3713820504757;581.1399129288676;583.5360888093976;584.4914924016091;11646.417679116095;11846.763064738658;11875.0499960003;11886.940565297205;11917.165798394115;8574.013988391353;8906.599203035814;8960.01439841617;9447.149756521878;9719.17387022104;8850.114988501162;9142.314326425478;9161.221296189766;9235.261179105655;9242.86135707965;2868.942621147565;2901.3181902252954;2937.4125174965093;2992.446397416485;2998.100569829064;38467.230655387015;38804.22391552181;38819.223615527815;38885.83342499758;39062;6620.9006864897065;6796.320367963263;6837.692303846339;7096.07750992378;7196.496245262886;10717.035466808025;10752.086072683753;10814.134869210444;10844.240903136704;10891.292066015683;5454.209139674725;5602.299712535933;5727.684977326204;5734.483896449339;5758.827235182951;3640.162762564625;3661.359262129117;3666.3400587894434;3717.237966216919;3718.4422336649177;2488.14159115105;2502.9749702503104;2508.072013355034;2508.184839927031;2508.8243822932586;400.6114069352723;402.961718636729;407.05766151359506;415.9438475805788;417.4573055028451;456.59591261733607;548.9953385304882;591.5297338615725;597.3667912013193;601.6781022153215;6863.485238607124;7353.522021068614;7489.550626962399;7524.209957954336;8413.537255450887;509.31751453053084;518.5592246590444;532.475511621053;585.7920438244447;647.9870402591922;3470.9132271692906;3541.2740388220354;3636.8181590920876;3643.7449378543247;3773.8301776420126;54501.45498545043;54812.17781733277;55305.1704224437;55406.16890746642;55468.72265638646;47468.76265618719;47615.52384476111;48047.279290810664;48322.516774832504;48559.27161092586;42369.78815105966;42386.57613423826;42693.57306426896;43023.56976430196;43142.56857431385;6779.220389655253;6832.419244364285;6889.655517224019;6947.5831450113155;7109.324614161646;31181.68818311788;31254.374912501167;31469.52795708112;31850.36299274048;31923.680763193;37441.251174975805;37572;39086.804565976985;41378.586214138675;41863.7906810464;6924.861502770017;7060.082189315356;7187.1734750504365;7252.963735181291;7515.549067055994;10612.416317102634;10653.57385704563;10681.198910081619;10999.725006874893;11038.613648522263;11050.941345232808;11079.169062320198;11120.388378639253;11150.665480035612;11243.10055195566;10451;10464.895351046393;10674;10792.730181745204;11115.11079113685;10652;10775.676729698122;10853;11142.665720028412;11210;9526.52367381642;9683.467409292274;9697.272704547046;9780.41317520951;9896.257780666334;8382.874256886029;8640.740777776677;8660.610272537624;9456.281197590508;9601.37591056607 05:30:11 INFO - 2015-11-13 05:30:11,373 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:11 INFO - 2015-11-13 05:30:11,373 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1447421411364__endTimestamp 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,374 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4791.39 Median:4906.88 stddev:513.31 (10.5%) stddev-sans-first:487.14 05:30:11 INFO - 2015-11-13 05:30:11,375 DEBUG : BROWSER_OUTPUT: Values: 2668.9 2707.6 2740.1 2744.4 2763.6 4730.5 4797.9 4852.4 4862.3 4909.2 4736.9 4751.6 4836.1 4852.4 4901.0 4396.4 4462.6 4466.2 4529.2 4569.2 4536.3 4599.7 4601.6 4609.4 4629.8 4288.7 4340.1 4373.7 4412.8 4508.4 4461.9 4465.0 4481.8 4492.0 4501.5 4430.6 4438.2 4446.5 4450.1 4469.8 4619.2 4691.0 4715.8 4765.3 4767.6 5219.7 5237.5 5248.1 5248.6 5267.1 5279.5 5286.4 5287.1 5289.9 5295.8 4644.2 4731.8 4744.4 4751.3 4761.3 5365.8 5410.6 5415.3 5418.1 5436.2 5175.8 5179.7 5185.6 5186.2 5221.3 5053.1 5054.1 5168.3 5254.4 5273.9 5160.4 5169.5 5185.7 5195.1 5202.8 5139.6 5147.9 5149.2 5154.9 5195.7 4181.4 4248.2 4298.1 4316.5 4321.7 3777.5 3782.3 3783.7 3785.4 3814.7 4495.8 4509.4 4521.7 4527.6 4546.5 5094.7 5204.8 5211.8 5227.2 5232.7 4442.7 4463.0 4557.2 4557.5 4573.5 4609.6 4626.9 4628.0 4628.4 4643.1 4737.5 4832.3 4906.9 4910.2 4917.6 5133.1 5244.7 5249.7 5285.8 5295.1 4877.1 4885.8 4890.4 4912.2 4951.0 4918.7 5004.7 5153.5 5169.8 5180.7 5102.8 5187.6 5191.8 5217.0 5252.7 5027.9 5044.7 5062.9 5063.7 5104.4 4844.2 4978.4 5006.5 5041.5 5050.4 4938.7 4988.0 5009.5 5024.8 5044.4 5086.7 5103.6 5104.2 5135.3 5158.4 4811.6 4857.4 4926.8 4985.4 4992.7 05:30:11 INFO - 2015-11-13 05:30:11,375 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,375 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38748.22 Median:33372.83 stddev:59800.52 (179.2%) stddev-sans-first:59899.46 05:30:11 INFO - 2015-11-13 05:30:11,376 DEBUG : BROWSER_OUTPUT: Values: 542.3 561.0 567.7 579.6 585.7 27885.7 28492.6 36726.8 37250.4 37448.1 39545.4 40434.8 40515.0 40579.4 40665.6 7881.8 8048.2 8066.8 8082.0 8103.7 7779.7 7893.6 7894.1 7935.3 7947.1 7943.2 8014.3 8016.9 8034.3 8053.9 7858.8 7962.5 7971.2 7975.0 7978.1 7720.7 7867.2 7905.6 7930.9 7947.5 37037.1 37315.4 37579.6 37612.0 37681.0 2802.7 2824.4 3167.8 3175.1 3622.1 27082.2 27616.3 27735.6 28035.3 28311.3 3078.3 3096.5 3101.1 3106.0 3199.3 210760.0 211417.0 211569.0 211645.0 212128.0 51157.0 52050.0 53040.5 53392.7 53459.7 56658.4 56693.4 56764.7 56983.0 56994.4 12947.2 13102.5 13137.1 13137.7 13147.0 9513.0 9594.9 9602.1 9612.3 9622.6 18622.4 18694.6 18797.3 18883.0 18973.5 7558.4 7774.9 7797.0 7814.3 7898.7 799.7 902.9 923.7 931.5 1015.6 22921.5 23619.5 25806.7 26501.3 26502.3 940.4 949.7 963.2 978.2 1019.0 12552.9 12622.1 12725.7 12737.3 12805.2 235568.0 244610.0 245113.0 245153.0 245174.0 43835.3 44031.6 44053.8 44054.6 44332.8 1127.2 1190.3 1198.1 1203.2 1206.5 24205.7 24238.8 24598.5 24638.1 24708.8 37822.2 38105.6 38224.6 38400.8 38483.0 232569.0 233249.0 234698.0 234790.0 235176.0 27581.9 28465.9 28655.3 28910.3 29066.9 34495.5 34637.1 35783.0 35930.8 37447.3 29818.6 30526.2 32902.5 33014.0 33608.3 32716.8 32737.8 32825.3 33004.7 33026.8 32611.2 33142.2 33310.8 33353.8 33391.8 26379.3 26737.5 29350.5 29414.4 30437.5 22072.0 23852.2 23969.8 24051.4 24156.4 05:30:11 INFO - 2015-11-13 05:30:11,376 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,376 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25971.30 Median:24363.59 stddev:86096.81 (353.4%) stddev-sans-first:86316.80 05:30:11 INFO - 2015-11-13 05:30:11,378 DEBUG : BROWSER_OUTPUT: Values: 330.2 330.5 334.8 337.0 338.6 10777.4 11111.8 11127.7 14668.4 15183.4 9030.3 9156.4 10278.4 10475.7 10493.4 4235.3 4373.3 4373.4 4388.5 4388.8 4307.7 4346.8 4352.3 4510.0 4582.6 4491.6 4553.8 4573.2 4613.6 4616.8 4513.7 4571.4 4597.1 4601.1 4607.6 4118.4 4146.6 4149.9 4160.0 4161.4 12013.1 12020.9 12064.2 12116.6 12297.5 528.5 1726.1 1752.1 1763.3 1807.4 9208.4 9369.0 9436.6 9475.3 9641.3 1628.7 1664.1 1671.8 1679.2 1689.4 46603.5 47027.3 47162.0 52930.7 55843.4 6425.7 6601.4 6621.8 6682.7 6701.2 7565.2 7636.6 7645.1 7652.3 7669.7 4917.6 4918.8 4937.6 4943.0 4960.9 4919.7 4925.8 5028.8 5066.8 5099.8 2960.3 2990.8 3016.8 3017.7 3027.6 1062.8 1080.5 1086.2 1088.2 1126.3 368.3 377.3 382.2 409.9 413.4 9099.5 9326.1 9349.3 9415.6 9864.3 397.3 399.3 403.9 413.7 435.8 4981.3 5023.4 5091.5 5720.3 5887.4 509347.2 514704.0 531746.0 538088.0 538709.0 66821.0 68004.0 68574.1 69023.7 69733.3 476.6 482.9 484.7 484.8 485.0 9692.0 9700.0 9712.2 9809.1 9841.2 31006.0 31742.4 31971.5 32120.5 32564.4 38776.6 38852.8 44235.6 45030.3 46313.8 13359.9 13428.3 13533.9 13874.3 13970.8 17804.6 18080.5 18238.0 18296.1 18303.4 8358.7 8682.8 14920.3 15180.7 15189.6 8823.6 9095.9 9142.3 9270.4 9496.0 8894.3 9503.3 9542.5 9783.2 9836.7 14020.4 14050.5 14137.8 14190.9 14346.6 14577.3 14742.6 14769.7 15123.7 15164.7 05:30:11 INFO - 2015-11-13 05:30:11,378 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,378 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4869.60 Median:6237.16 stddev:2523.36 (40.5%) stddev-sans-first:2517.59 05:30:11 INFO - 2015-11-13 05:30:11,378 DEBUG : BROWSER_OUTPUT: Values: 1481.2 1637.9 1689.6 1716.7 1719.9 6001.7 6101.1 6928.2 7121.0 7147.5 6635.6 6762.4 6769.4 6809.1 6821.6 2042.9 2085.1 2085.7 2085.8 2089.0 2056.2 2094.9 2102.1 2109.9 2115.3 2032.9 2034.8 2061.8 2063.1 2076.6 2050.2 2070.3 2082.7 2082.9 2086.8 2053.7 2066.9 2085.5 2090.2 2093.6 6749.8 6780.1 6825.6 6879.8 6905.0 4017.8 4044.8 4073.8 4074.5 4109.6 2643.1 2652.9 2686.7 2713.1 2726.0 878.6 896.7 901.3 909.3 942.0 8789.6 8789.6 8791.7 8791.7 8794.3 3629.3 3652.7 3680.6 3690.3 3702.1 7542.7 7634.1 7670.6 7677.3 7691.3 3941.3 3945.5 3975.0 3980.7 3992.0 3609.8 3636.1 3700.8 3815.1 3833.2 3151.8 3197.9 3227.1 3228.7 3243.5 924.5 926.9 927.4 930.4 953.7 1181.4 1181.9 1193.1 1196.8 1204.1 6714.7 6762.2 6767.3 6769.4 6775.5 420.2 425.0 428.1 434.3 434.4 5201.5 5257.4 5268.6 5272.0 5286.4 8489.1 8505.1 8647.3 8689.4 8703.1 8594.4 8606.1 8615.4 8662.2 8673.8 6537.5 6570.6 6584.0 6647.3 6854.1 6259.5 6261.6 6278.4 6285.8 6292.4 7357.2 7451.4 7668.7 7716.8 7749.7 7452.7 7704.6 7750.8 7891.0 7898.5 5324.2 5422.8 6163.5 6228.3 6246.1 6620.8 6767.9 6772.5 6804.3 6813.0 6390.0 6392.9 6516.3 6517.3 6522.2 6313.7 6316.3 6367.9 6451.5 6508.8 6537.5 6548.4 6561.5 6569.5 6579.7 5826.2 6092.4 6134.6 6136.8 6145.8 6187.3 6206.7 6209.7 6210.3 6226.5 05:30:11 INFO - 2015-11-13 05:30:11,379 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,379 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4933.64 Median:5634.95 stddev:1478.99 (26.2%) stddev-sans-first:1441.95 05:30:11 INFO - 2015-11-13 05:30:11,380 DEBUG : BROWSER_OUTPUT: Values: 315.6 316.3 322.8 323.2 323.5 5602.4 5672.9 5695.9 5758.4 5808.5 5598.5 5667.5 5677.5 5688.1 5710.9 4199.3 4309.6 4327.9 4341.5 4347.0 4291.4 4342.4 4343.7 4345.0 4345.8 4291.5 4292.6 4300.2 4301.4 4303.7 4290.7 4292.3 4294.7 4299.4 4310.0 3647.1 3729.5 3733.2 3751.8 3753.8 5406.4 5482.8 5485.3 5491.3 5494.8 4943.2 4959.1 4959.6 4967.5 4970.3 5977.6 5984.6 5992.2 5999.9 6006.1 3970.3 4073.5 4081.6 4083.3 4094.8 6217.7 6237.8 6276.6 6282.2 6282.4 4176.9 4184.5 4186.0 4187.6 4189.0 4256.9 4259.5 4261.7 4264.3 4269.2 4793.0 4798.7 4854.2 4912.7 4924.8 5904.1 5908.9 5917.1 5938.9 5939.8 1496.5 1504.8 1511.2 1511.3 1512.8 991.7 1009.2 1009.8 1017.4 1027.5 5134.1 5146.9 5163.4 5164.0 5168.7 6146.1 6167.6 6170.3 6183.3 6192.9 5130.6 5132.0 5141.8 5142.3 5142.7 3293.2 3332.9 3349.2 3374.9 3380.7 5855.1 5856.1 5870.5 5875.3 5877.3 6468.0 6472.7 6473.9 6478.6 6483.4 5685.2 5849.8 5850.1 5854.7 5871.7 6291.1 6292.2 6293.1 6301.0 6314.1 6116.5 6119.6 6128.8 6129.8 6140.1 5698.8 5838.0 5858.8 5863.3 5869.0 4182.6 4214.1 4218.8 4220.1 4222.2 6088.9 6207.8 6273.5 6281.7 6287.7 6006.0 6016.2 6019.2 6035.5 6035.9 5953.5 5995.9 5996.7 6002.8 6011.6 5692.3 5854.6 5874.5 5891.5 5900.3 6014.4 6038.4 6050.8 6058.8 6076.9 5841.7 5908.5 5909.5 5910.1 5919.5 05:30:11 INFO - 2015-11-13 05:30:11,380 DEBUG : BROWSER_OUTPUT: 05:30:11 INFO - 2015-11-13 05:30:11,381 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12111.55 Median:24534.29 stddev:14569.91 (59.4%) stddev-sans-first:14585.24 05:30:11 INFO - 2015-11-13 05:30:11,381 DEBUG : BROWSER_OUTPUT: Values: 622.3 664.8 744.7 750.0 759.0 11442.3 11787.9 11806.0 11840.6 11858.0 11561.4 12769.4 12945.2 12979.9 12994.3 757.6 764.2 773.9 775.9 778.6 775.2 776.1 776.1 779.1 781.8 791.2 793.4 797.3 798.1 802.1 779.9 783.3 789.9 791.9 792.2 578.7 579.4 581.1 583.5 584.5 11646.4 11846.8 11875.0 11886.9 11917.2 8574.0 8906.6 8960.0 9447.1 9719.2 8850.1 9142.3 9161.2 9235.3 9242.9 2868.9 2901.3 2937.4 2992.4 2998.1 38467.2 38804.2 38819.2 38885.8 39062.0 6620.9 6796.3 6837.7 7096.1 7196.5 10717.0 10752.1 10814.1 10844.2 10891.3 5454.2 5602.3 5727.7 5734.5 5758.8 3640.2 3661.4 3666.3 3717.2 3718.4 2488.1 2503.0 2508.1 2508.2 2508.8 400.6 403.0 407.1 415.9 417.5 456.6 549.0 591.5 597.4 601.7 6863.5 7353.5 7489.6 7524.2 8413.5 509.3 518.6 532.5 585.8 648.0 3470.9 3541.3 3636.8 3643.7 3773.8 54501.5 54812.2 55305.2 55406.2 55468.7 47468.8 47615.5 48047.3 48322.5 48559.3 42369.8 42386.6 42693.6 43023.6 43142.6 6779.2 6832.4 6889.7 6947.6 7109.3 31181.7 31254.4 31469.5 31850.4 31923.7 37441.3 37572.0 39086.8 41378.6 41863.8 6924.9 7060.1 7187.2 7253.0 7515.5 10612.4 10653.6 10681.2 10999.7 11038.6 11050.9 11079.2 11120.4 11150.7 11243.1 10451.0 10464.9 10674.0 10792.7 11115.1 10652.0 10775.7 10853.0 11142.7 11210.0 9526.5 9683.5 9697.3 9780.4 9896.3 8382.9 8640.7 8660.6 9456.3 9601.4 05:30:11 INFO - 2015-11-13 05:30:11,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:11 INFO - 2015-11-13 05:30:11,381 DEBUG : BROWSER_OUTPUT: 05:30:12 INFO - 2015-11-13 05:30:12,965 INFO : Browser exited with error code: 0 05:30:12 INFO - 2015-11-13 05:30:12,984 INFO : Completed test dromaeo_css (00:19:45) 05:30:12 INFO - 2015-11-13 05:30:12,984 INFO : Starting test kraken 05:30:12 INFO - 2015-11-13 05:30:12,984 DEBUG : operating with platform_type : linux_ 05:30:12 INFO - 2015-11-13 05:30:12,984 INFO : Initialising browser for kraken test... 05:30:12 INFO - 2015-11-13 05:30:12,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XXwUP/profile http://localhost:58360/getInfo.html 05:30:30 INFO - 2015-11-13 05:30:30,657 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:30 INFO - 2015-11-13 05:30:30,657 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:30 INFO - 2015-11-13 05:30:30,657 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:30:30 INFO - 2015-11-13 05:30:30,657 DEBUG : BROWSER_OUTPUT: __metrics 05:30:31 INFO - 2015-11-13 05:30:31,219 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:30:33 INFO - 2015-11-13 05:30:33,081 INFO : Browser initialized. 05:30:33 INFO - 2015-11-13 05:30:33,081 INFO : Running cycle 1/1 for kraken test... 05:30:33 INFO - 2015-11-13 05:30:33,082 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XXwUP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:44 INFO - 2015-11-13 05:30:44,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 141430784 05:30:44 INFO - 2015-11-13 05:30:44,995 DEBUG : BROWSER_OUTPUT: 05:30:47 INFO - 2015-11-13 05:30:47,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58360/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:48 INFO - 2015-11-13 05:30:48,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 142204928 05:30:48 INFO - 2015-11-13 05:30:48,199 DEBUG : BROWSER_OUTPUT: 05:30:50 INFO - 2015-11-13 05:30:50,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58360/tests/kraken/driver.html?testName=audio-dft) 05:30:51 INFO - 2015-11-13 05:30:51,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 05:30:51 INFO - 2015-11-13 05:30:51,555 DEBUG : BROWSER_OUTPUT: 05:30:54 INFO - 2015-11-13 05:30:54,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58360/tests/kraken/driver.html?testName=audio-fft) 05:30:55 INFO - 2015-11-13 05:30:55,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 136118272 05:30:55 INFO - 2015-11-13 05:30:55,039 DEBUG : BROWSER_OUTPUT: 05:30:57 INFO - 2015-11-13 05:30:57,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58360/tests/kraken/driver.html?testName=audio-oscillator) 05:30:57 INFO - 2015-11-13 05:30:57,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 136945664 05:30:57 INFO - 2015-11-13 05:30:57,805 DEBUG : BROWSER_OUTPUT: 05:31:00 INFO - 2015-11-13 05:31:00,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:00 INFO - 2015-11-13 05:31:00,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 137674752 05:31:00 INFO - 2015-11-13 05:31:00,621 DEBUG : BROWSER_OUTPUT: 05:31:03 INFO - 2015-11-13 05:31:03,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58360/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:04 INFO - 2015-11-13 05:31:04,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 138530816 05:31:04 INFO - 2015-11-13 05:31:04,262 DEBUG : BROWSER_OUTPUT: 05:31:07 INFO - 2015-11-13 05:31:07,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58360/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:08 INFO - 2015-11-13 05:31:08,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 137142272 05:31:08 INFO - 2015-11-13 05:31:08,338 DEBUG : BROWSER_OUTPUT: 05:31:11 INFO - 2015-11-13 05:31:11,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58360/tests/kraken/driver.html?testName=json-parse-financial) 05:31:11 INFO - 2015-11-13 05:31:11,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 137895936 05:31:11 INFO - 2015-11-13 05:31:11,898 DEBUG : BROWSER_OUTPUT: 05:31:13 INFO - 2015-11-13 05:31:13,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:14 INFO - 2015-11-13 05:31:14,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 138252288 05:31:14 INFO - 2015-11-13 05:31:14,241 DEBUG : BROWSER_OUTPUT: 05:31:16 INFO - 2015-11-13 05:31:16,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:16 INFO - 2015-11-13 05:31:16,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 138293248 05:31:16 INFO - 2015-11-13 05:31:16,718 DEBUG : BROWSER_OUTPUT: 05:31:18 INFO - 2015-11-13 05:31:18,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:19 INFO - 2015-11-13 05:31:19,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 05:31:19 INFO - 2015-11-13 05:31:19,441 DEBUG : BROWSER_OUTPUT: 05:31:21 INFO - 2015-11-13 05:31:21,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:22 INFO - 2015-11-13 05:31:22,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 05:31:22 INFO - 2015-11-13 05:31:22,598 DEBUG : BROWSER_OUTPUT: 05:31:25 INFO - 2015-11-13 05:31:25,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:25 INFO - 2015-11-13 05:31:25,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 139325440 05:31:25 INFO - 2015-11-13 05:31:25,827 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58360/tests/kraken/driver.html?testName=ai-astar) 05:31:27 INFO - 2015-11-13 05:31:27,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 05:31:27 INFO - 2015-11-13 05:31:27,858 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;112;111;113;122;113;112;111;113 05:31:27 INFO - 2015-11-13 05:31:27,860 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;157;171;141;155;154;138;171;133 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;163;162;165;173;163;167;163 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;72;74;73;129;78;73;72 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;131;90;91;91;132;91;92;124 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;111;110;110;110;109;110;110 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;147;148;147;148;150;149;149;148;148 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;96;96;97;96;96;96;96;97 05:31:27 INFO - 2015-11-13 05:31:27,861 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;71;73;73;73;73;72;74;69 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;66;67;73;68;67;67;67;67 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;84;84;83;86;82;85;85;85;84 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;127;129;120;135;124;126;131;133 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;160;151;147;165;158;151;146;138;147 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;72;68;74;69;68;69;69;68;70 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:31:27 INFO - 2015-11-13 05:31:27,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,786 05:31:27 INFO - 2015-11-13 05:31:27,863 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:31:27 INFO - 2015-11-13 05:31:27,863 DEBUG : BROWSER_OUTPUT: __startTimestamp1447421487858__endTimestamp 05:31:27 INFO - 2015-11-13 05:31:27,863 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,870 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:3.58 (3.2%) stddev-sans-first:3.80 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 112.0 111.0 113.0 122.0 113.0 112.0 111.0 113.0 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:156.00 stddev:14.49 (9.3%) stddev-sans-first:15.19 05:31:27 INFO - 2015-11-13 05:31:27,871 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 157.0 171.0 141.0 155.0 154.0 138.0 171.0 133.0 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.41 (2.1%) stddev-sans-first:3.50 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 163.0 162.0 165.0 173.0 163.0 167.0 163.0 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:17.62 (24.1%) stddev-sans-first:18.55 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 72.0 74.0 73.0 129.0 78.0 73.0 72.0 05:31:27 INFO - 2015-11-13 05:31:27,872 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:91.00 stddev:18.41 (20.2%) stddev-sans-first:19.05 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 131.0 90.0 91.0 91.0 132.0 91.0 92.0 124.0 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.27 (0.9%) stddev-sans-first:0.97 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 148.0 147.0 148.0 150.0 149.0 149.0 148.0 148.0 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:31:27 INFO - 2015-11-13 05:31:27,873 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.40 Median:73.00 stddev:1.43 (2.0%) stddev-sans-first:1.50 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 73.0 73.0 73.0 73.0 72.0 74.0 69.0 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:1.95 (2.9%) stddev-sans-first:2.06 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 67.0 73.0 68.0 67.0 67.0 67.0 67.0 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 84.0 83.0 86.0 82.0 85.0 85.0 85.0 84.0 05:31:27 INFO - 2015-11-13 05:31:27,874 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.00 stddev:5.54 (4.3%) stddev-sans-first:5.17 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 127.0 129.0 120.0 135.0 124.0 126.0 131.0 133.0 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.00 stddev:7.94 (5.3%) stddev-sans-first:8.29 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: Values: 147.0 160.0 151.0 147.0 165.0 158.0 151.0 146.0 138.0 147.0 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: 05:31:27 INFO - 2015-11-13 05:31:27,875 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:2.21 (3.2%) stddev-sans-first:2.06 05:31:27 INFO - 2015-11-13 05:31:27,876 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 68.0 74.0 69.0 68.0 69.0 69.0 68.0 70.0 05:31:27 INFO - 2015-11-13 05:31:27,876 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:27 INFO - 2015-11-13 05:31:27,876 DEBUG : BROWSER_OUTPUT: 05:31:28 INFO - 2015-11-13 05:31:28,849 INFO : Browser exited with error code: 0 05:31:28 INFO - 2015-11-13 05:31:28,903 INFO : Completed test kraken (00:01:15) 05:31:28 INFO - 2015-11-13 05:31:28,903 INFO : Starting test v8_7 05:31:28 INFO - 2015-11-13 05:31:28,903 DEBUG : operating with platform_type : linux_ 05:31:28 INFO - 2015-11-13 05:31:28,903 INFO : Initialising browser for v8_7 test... 05:31:28 INFO - 2015-11-13 05:31:28,909 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJdqPQ/profile http://localhost:58360/getInfo.html 05:31:47 INFO - 2015-11-13 05:31:47,706 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:47 INFO - 2015-11-13 05:31:47,707 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:47 INFO - 2015-11-13 05:31:47,707 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:31:47 INFO - 2015-11-13 05:31:47,707 DEBUG : BROWSER_OUTPUT: __metrics 05:31:50 INFO - 2015-11-13 05:31:50,677 INFO : Browser initialized. 05:31:50 INFO - 2015-11-13 05:31:50,677 INFO : Running cycle 1/1 for v8_7 test... 05:31:50 INFO - 2015-11-13 05:31:50,678 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJdqPQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:32:02 INFO - 2015-11-13 05:32:02,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 140484608 05:32:02 INFO - 2015-11-13 05:32:02,559 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58360/tests/v8_7/run.html (next: http://localhost:58360/tests/v8_7/run.html) 05:32:24 INFO - 2015-11-13 05:32:24,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 137662464 05:32:24 INFO - 2015-11-13 05:32:24,336 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,337 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:32:24 INFO - 2015-11-13 05:32:24,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:32:24 INFO - 2015-11-13 05:32:24,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:32:24 INFO - 2015-11-13 05:32:24,337 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:32:24 INFO - 2015-11-13 05:32:24,337 DEBUG : BROWSER_OUTPUT: |0;Richards;163.71971185330713 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |5;Earley;725.8883248730964 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |6;Boyer;11800 05:32:24 INFO - 2015-11-13 05:32:24,338 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: |8;Splay;611.9951040391677 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: __startTimestamp1447421544336__endTimestamp 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,339 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:32:24 INFO - 2015-11-13 05:32:24,340 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:32:24 INFO - 2015-11-13 05:32:24,340 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.72 Median:163.72 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: Values: 163.7 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: Values: 188.6 05:32:24 INFO - 2015-11-13 05:32:24,341 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: Values: 280.0 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: Values: 5060.6 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: Values: 1071.8 05:32:24 INFO - 2015-11-13 05:32:24,342 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:725.89 Median:725.89 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: Values: 725.9 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11800.00 Median:11800.00 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: Values: 11800.0 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,343 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: Values: 25974.4 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.00 Median:612.00 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: Values: 612.0 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: 05:32:24 INFO - 2015-11-13 05:32:24,344 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:32:24 INFO - 2015-11-13 05:32:24,345 DEBUG : BROWSER_OUTPUT: Values: 4826.9 05:32:24 INFO - 2015-11-13 05:32:24,345 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:32:24 INFO - 2015-11-13 05:32:24,345 DEBUG : BROWSER_OUTPUT: 05:32:25 INFO - 2015-11-13 05:32:25,945 INFO : Browser exited with error code: 0 05:32:25 INFO - 2015-11-13 05:32:25,962 INFO : Completed test v8_7 (00:00:57) 05:32:26 INFO - 2015-11-13 05:32:26,074 INFO : Completed test suite (00:21:58) 05:32:26 INFO - 2015-11-13 05:32:26,074 DEBUG : Working with test: dromaeo_css 05:32:26 INFO - 2015-11-13 05:32:26,074 DEBUG : Generating results file: dromaeo_css 05:32:26 INFO - 2015-11-13 05:32:26,076 DEBUG : Working with test: kraken 05:32:26 INFO - 2015-11-13 05:32:26,076 DEBUG : Generating results file: kraken 05:32:26 INFO - 2015-11-13 05:32:26,076 INFO : javascript benchmark 05:32:26 INFO - 2015-11-13 05:32:26,077 DEBUG : Working with test: v8_7 05:32:26 INFO - 2015-11-13 05:32:26,077 DEBUG : Generating results file: v8_7 05:32:26 INFO - 2015-11-13 05:32:26,077 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:26 INFO - 2015-11-13 05:32:26,131 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:32:26 INFO - 2015-11-13 05:32:26,131 DEBUG : process_Request line: dromaeo_css 6062.20 graph.html#tests=[[72,132,43]] 05:32:26 INFO - 2015-11-13 05:32:26,131 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:26 INFO - 2015-11-13 05:32:26,166 DEBUG : process_Request line: kraken 1536.40 graph.html#tests=[[232,132,43]] 05:32:26 INFO - 2015-11-13 05:32:26,166 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:26 INFO - 2015-11-13 05:32:26,193 DEBUG : process_Request line: v8_7 21407.57 graph.html#tests=[[230,132,43]] 05:32:26 INFO - 2015-11-13 05:32:26,194 INFO : javascript benchmark 05:32:26 INFO - 2015-11-13 05:32:26,198 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.15936155930694, 330.5058936889351, 334.8426239667356, 336.98652053917846, 338.6055245638831, 10777.353358798478, 11111.833322500159, 11127.72180695483, 14668.413263469462, 15183.39266429343, 9030.277577793777, 9156.404833685805, 10278.434686092261, 10475.68572942811, 10493.422861742602, 4235.343521754133, 4373.300271956472, 4373.387725718402, 4388.539203383631, 4388.780560971939, 4307.698461107724, 4346.782660866944, 4352.325389564607, 4510.030343476152, 4582.587567118959, 4491.6182124519455, 4553.795079221426, 4573.222552166123, 4613.561711637389, 4616.838410655628, 4513.7066090704, 4571.428571428572, 4597.057603191354, 4601.125786100647, 4607.631389488833, 4118.382242663594, 4146.5853414658295, 4149.854755083587, 4159.958400416018, 4161.438205842233, 12013.099017573717, 12020.879791202064, 12064.155509114365, 12116.636500904988, 12297.508099676003, 528.4662490884197, 1726.067923321405, 1752.1326943163087, 1763.312308199803, 1807.3854889337556, 9208.447493150432, 9369.0, 9436.622535098588, 9475.336726429152, 9641.325107242426, 1628.7149748793913, 1664.1097013097935, 1671.849533541975, 1679.2359476438314, 1689.408706952569, 46603.5339646606, 47027.29459058117, 47162.0, 52930.73534632341, 55843.44156558464, 6425.74297028123, 6601.438877695354, 6621.768238111643, 6682.732690692415, 6701.229358623723, 7565.205653406423, 7636.579988100708, 7645.120811106683, 7652.273034061755, 7669.7315593953945, 4917.557419832161, 4918.803247870045, 4937.580305673986, 4942.950570494321, 4960.851174464772, 4919.729414882216, 4925.75371231437, 5028.823991160292, 5066.771995260222, 5099.770510327045, 2960.3487232808748, 2990.7607391408637, 3016.8189908605555, 3017.6680565137817, 3027.6366835979825, 1062.7661914378825, 1080.524569189554, 1086.163653986426, 1088.2382332367374, 1126.2631804714458, 368.28368822640243, 377.33400548032745, 382.24315854608034, 409.8852321350027, 413.3881854854832, 9099.545022748836, 9326.114019168168, 9349.252059835197, 9415.576299066559, 9864.309498335047, 397.2908358579921, 399.29325094582424, 403.9434479172918, 413.65046535677305, 435.84527492740256, 4981.252812078217, 5023.447420783711, 5091.541761241506, 5720.342160651495, 5887.411258874078, 509347.2491069819, 514704.0, 531746.0, 538088.0, 538709.0, 66821.0, 68004.0, 68574.1139768923, 69023.65488172628, 69733.3026669737, 476.5568021739815, 482.88652166740786, 484.6922204400231, 484.7551986246923, 484.9515048495122, 9692.0, 9699.951500242454, 9712.223022158068, 9809.117179453884, 9841.212702983601, 31006.0, 31742.36515269728, 31971.520427194075, 32120.518192226667, 32564.417914029913, 38776.612233878426, 38852.80573597114, 44235.55764442443, 45030.324545131196, 46313.76843115763, 13359.933200333937, 13428.328583570978, 13533.86466135326, 13874.306284685523, 13970.79043814364, 17804.55488612795, 18080.547986300448, 18238.0, 18296.085195740427, 18303.35938242155, 8358.707445239388, 8682.78293042679, 14920.328585213474, 15180.696386072437, 15189.620259493158, 8823.558822058743, 9095.909040909506, 9142.26861851037, 9270.44377337362, 9495.952520237632, 8894.33292503052, 9503.287253456157, 9542.522873856418, 9783.168430683472, 9836.704898853046, 14020.369083391475, 14050.508232211823, 14137.787933180805, 14190.858091418953, 14346.641333966734, 14577.271136443347, 14742.557723268319, 14769.704605908037, 15123.697526049198, 15164.696706065597], "dojo.html": [2668.8532130732806, 2707.648005759251, 2740.1368568900793, 2744.4236710290825, 2763.5854621806734, 4730.4559975602815, 4797.880052998672, 4852.393450818648, 4862.343583616215, 4909.214525675892, 4736.905261894769, 4751.572358487735, 4836.105320515707, 4852.393450818648, 4901.019796040789, 4396.4284642996445, 4462.620677242422, 4466.151431228056, 4529.230030894756, 4569.200389931765, 4536.251518499444, 4599.655025873056, 4601.608863246612, 4609.354690343338, 4629.837955671552, 4288.69979101463, 4340.110277393127, 4373.671974601918, 4412.823487060546, 4508.413906192191, 4461.866144015685, 4465.0, 4481.77591120446, 4491.955080449186, 4501.4598248210095, 4430.623397011258, 4438.178936896685, 4446.510883802779, 4450.10997800438, 4469.843555475542, 4619.214733495314, 4690.976545117287, 4715.7877895494785, 4765.28520721891, 4767.642426817968, 5219.686818790885, 5237.4500677428705, 5248.107821670325, 5248.580113590903, 5267.104592219293, 5279.498447647506, 5286.365636123652, 5287.101192797234, 5289.947100528984, 5295.814646487393, 4644.210484217691, 4731.834385796481, 4744.383230180055, 4751.287306903992, 4761.333413322069, 5365.7585408656705, 5410.648307859977, 5415.296011518556, 5418.078926582491, 5436.157395603688, 5175.767090480937, 5179.741012949337, 5185.611079169077, 5186.247994040843, 5221.347331583552, 5053.1157047516535, 5054.064997975386, 5168.250603662448, 5254.395744489432, 5273.894522109536, 5160.354955630546, 5169.53474187325, 5185.688858668492, 5195.090859099642, 5202.843914682566, 5139.614528910347, 5147.948520514822, 5149.150390185652, 5154.9484505155215, 5195.740212989411, 4181.372794080851, 4248.171606536695, 4298.118885628502, 4316.460442444694, 4321.65426765858, 3777.490038844776, 3782.2813665403487, 3783.735138540276, 3785.37541305687, 3814.6757525610633, 4495.797689103998, 4509.391232183679, 4521.728696278234, 4527.637788976874, 4546.52261512543, 5094.694318340911, 5204.76578553966, 5211.7915283389, 5227.242049902743, 5232.73836308183, 4442.73343599385, 4463.0, 4557.15692596864, 4557.498675145797, 4573.5426457354, 4609.631229501699, 4626.86119416418, 4628.0, 4628.375169352162, 4643.117807616542, 4737.455192652751, 4832.299316599144, 4906.877328066756, 4910.165271903785, 4917.6311776616185, 5133.050385678512, 5244.711540865136, 5249.711265880261, 5285.788568457372, 5295.12630415977, 4877.146499362669, 4885.7801398937845, 4890.437599676083, 4912.164931961646, 4950.975245123751, 4918.655694101379, 5004.749762511933, 5153.45888681683, 5169.793208271627, 5180.7409629517615, 5102.821401251087, 5187.559057480156, 5191.844244672666, 5216.9739151304, 5252.737363131904, 5027.924581131213, 5044.747762611782, 5062.873428164326, 5063.721495317645, 5104.3619547556555, 4844.15227335222, 4978.377702787152, 5006.524380183877, 5041.521055499722, 5050.444451110448, 4938.728369939688, 4987.9750601248215, 5009.474005229544, 5024.824131155392, 5044.369453818273, 5086.720230387365, 5103.642745007814, 5104.183330667075, 5135.306733590917, 5158.3552055993005, 4811.615070794258, 4857.417109946829, 4926.753662316798, 4985.401751789664, 4992.675476094042], "mootools.html": [1481.237162861126, 1637.8689704823612, 1689.6113893804425, 1716.6652502761963, 1719.948401547954, 6001.729922153502, 6101.084837274411, 6928.237893831681, 7120.999999999994, 7147.53541019834, 6635.568688035274, 6762.425193858516, 6769.424598909086, 6809.148856392951, 6821.556598821086, 2042.9387118386471, 2085.092984551725, 2085.6975738517904, 2085.8122768950793, 2089.028601700209, 2056.1878058167017, 2094.9476263093393, 2102.127617038927, 2109.92615258466, 2115.3125234298836, 2032.9390118296474, 2034.7965203479607, 2061.835053195741, 2063.071617772001, 2076.636588596997, 2050.2004218354855, 2070.254708305009, 2082.6875968604754, 2082.864613800106, 2086.843486738501, 2053.650879350514, 2066.90698918549, 2085.4577809769416, 2090.153487837428, 2093.5812837432572, 6749.831254218684, 6780.118584583973, 6825.590464572092, 6879.759208427731, 6905.033295338657, 4017.7790221537803, 4044.8382064717375, 4073.796310184479, 4074.5110586729484, 4109.630133288018, 2643.1409791817546, 2652.9469410611873, 2686.7044625091225, 2713.131797824697, 2726.005008172003, 878.5651102704138, 896.6682327538853, 901.3150005995425, 909.2998391238775, 941.9638397762475, 8789.604467798901, 8789.64841406343, 8791.692290769792, 8791.736247912573, 8794.252488538483, 3629.310431018098, 3652.726045546595, 3680.595134535199, 3690.2988432197794, 3702.1114932416026, 7542.6605802739, 7634.083909930733, 7670.619288528007, 7677.30904218623, 7691.346235570039, 3941.2708648900043, 3945.506811648544, 3975.0, 3980.7014473914574, 3991.960080399217, 3609.801460919675, 3636.054625797312, 3700.8149592520267, 3815.1225218199415, 3833.21419109082, 3151.7636177286336, 3197.8560964756643, 3227.064151396116, 3228.6609905960004, 3243.5296881951986, 924.4545718026396, 926.8748718922994, 927.4064598656865, 930.3952430919957, 953.7329547726648, 1181.3915833345834, 1181.8936295733254, 1193.087288224509, 1196.8264601632713, 1204.114975493012, 6714.697838597275, 6762.222344430454, 6767.255601883789, 6769.3907548320885, 6775.4918381121615, 420.18274456182434, 424.96812739044697, 428.1031239553131, 434.2725934060436, 434.35715141590623, 5201.505856943584, 5257.447967963309, 5268.552173065333, 5272.024675435056, 5286.418493965661, 8489.066202717697, 8505.149485051445, 8647.308215342757, 8689.435186712843, 8703.129687031245, 8594.355423343275, 8606.096359882247, 8615.39692221551, 8662.177093176138, 8673.783155421164, 6537.477001839841, 6570.638614876132, 6584.0, 6647.335266473314, 6854.143232095988, 6259.467945224706, 6261.5616906816085, 6278.372162783685, 6285.811425657238, 6292.433680968735, 7357.227491113356, 7451.3666338361845, 7668.6549105291515, 7716.7684969451, 7749.7287594933905, 7452.664630091767, 7704.614769261402, 7750.844983100419, 7890.9605451972375, 7898.486598371088, 5324.1747529133045, 5422.783088676409, 6163.537734669828, 6228.252609686867, 6246.063090536274, 6620.834479137868, 6767.898481522682, 6772.492063095189, 6804.285550017375, 6813.0461735358085, 6390.0, 6392.93607063942, 6516.315786842313, 6517.315681853527, 6522.184726909137, 6313.684315784284, 6316.273628532594, 6367.90448143269, 6451.516136289703, 6508.772192973223, 6537.542372033912, 6548.410643042149, 6561.475081993524, 6569.4744420447205, 6579.671016449254, 5826.213461182856, 6092.421219984094, 6134.601250918855, 6136.754529818757, 6145.8156255312415, 6187.288461826767, 6206.72069756853, 6209.720562574786, 6210.347913469021, 6226.50187984951], "ext.html": [542.2528649958075, 560.9691466969315, 567.7246535430313, 579.5913880714097, 585.7393459910339, 27885.721142788567, 28492.57261141082, 36726.81636591817, 37250.441243381305, 37448.063798405055, 39545.40681889774, 40434.79782601083, 40515.0, 40579.39130913031, 40665.593344066554, 7881.802954926144, 8048.154943730882, 8066.7579972600915, 8082.0, 8103.716369927054, 7779.688812447495, 7893.565853878034, 7894.131645518988, 7935.325497332734, 7947.08608510023, 7943.165967573408, 8014.3187829034605, 8016.919830801705, 8034.276915077642, 8053.919460805376, 7858.764237072897, 7962.522248665098, 7971.242731940456, 7975.0, 7978.082520510157, 7720.691172353099, 7867.173946735625, 7905.644246008944, 7930.881036784453, 7947.523148611044, 37037.07407314812, 37315.44026839572, 37579.62420375816, 37612.0, 37681.0, 2802.66368035837, 2824.378636699923, 3167.7782555221143, 3175.063356309894, 3622.0763705255254, 27082.187534374, 27616.309592260153, 27735.583966240523, 28035.29911752202, 28311.292217694518, 3078.2612173078523, 3096.4735994880925, 3101.1316831287277, 3106.0, 3199.3281410903737, 210760.0, 211417.0, 211569.0, 211645.0, 212128.0, 51157.0, 52050.0, 53040.46959530433, 53392.73303633457, 53459.732701336245, 56658.43341566614, 56693.43306566882, 56764.71617641968, 56983.0, 56994.43005569974, 12947.223166609845, 13102.541411050568, 13137.146085504412, 13137.73724525504, 13147.0, 9513.048695130432, 9594.904050959542, 9602.135807777333, 9612.327137100336, 9622.566984485575, 18622.441326760218, 18694.626107477776, 18797.34209302668, 18883.0, 18973.525661858286, 7558.357539609195, 7774.922250777533, 7797.0, 7814.257645523666, 7898.723544675909, 799.6921185343568, 902.8961669407971, 923.7413524213231, 931.469062634292, 1015.6496008876926, 22921.541569168858, 23619.527609447716, 25806.741932580808, 26501.33746656349, 26502.33744156373, 940.3887473142512, 949.6818565780403, 963.2197919685077, 978.1636700621009, 1019.0370100255336, 12552.937235313764, 12622.116451848282, 12725.68185795344, 12737.299448530235, 12805.167664101804, 235568.0, 244610.0, 245113.0, 245153.0, 245174.0, 43835.342469862975, 44031.559684403386, 44053.77973110114, 44054.55945440569, 44332.77833610812, 1127.1771606727134, 1190.2501424102759, 1198.0894520164738, 1203.1878482024774, 1206.4631239098517, 24205.74432888645, 24238.757612424357, 24598.508029838944, 24638.13766518163, 24708.76456177148, 37822.243555128196, 38105.61894381021, 38224.617753823215, 38400.80799595984, 38483.0, 232569.0, 233249.0, 234698.0, 234790.0, 235176.0, 27581.862090689418, 28465.857670711513, 28655.283617909718, 28910.27724306825, 29066.854665726536, 34495.482567762, 34637.13407164841, 35783.0, 35930.8203458981, 37447.2510549782, 29818.55272170876, 30526.236844079074, 32902.506462402605, 33014.0, 33608.32783344271, 32716.83641581777, 32737.836310818293, 32825.34349312953, 33004.66995330112, 33026.83486582552, 32611.18472038218, 33142.17144571405, 33310.83344583261, 33353.83323083369, 33391.83304083464, 26379.340516487242, 26737.465250695266, 29350.47219829836, 29414.41171176607, 30437.543436848908, 22072.0, 23852.16517421882, 23969.76030239745, 24051.398715032265, 24156.39609009789], "prototype.html": [315.5897333466494, 316.3309600195587, 322.75309388317936, 323.159252286574, 323.5050372929419, 5602.4117467665865, 5672.914906276409, 5695.8576035599135, 5758.366579676237, 5808.506276966463, 5598.4961353478175, 5667.489925906668, 5677.48902598766, 5688.089905615102, 5710.885782284352, 4199.2651286024975, 4309.612134907866, 4327.913441731163, 4341.45731783527, 4346.9565304347025, 4291.420658211133, 4342.392065110887, 4343.6959412841115, 4344.956550434503, 4345.8478953236645, 4291.527931927485, 4292.613664770186, 4300.161468513641, 4301.37630043645, 4303.655707543389, 4290.69965102443, 4292.270314046604, 4294.656427485794, 4299.376590394407, 4309.956900430987, 3647.1064589175558, 3729.4778730977687, 3733.1600389912323, 3751.7748935063983, 3753.8498460061564, 5406.405295417501, 5482.80810171646, 5485.314335708036, 5491.313585801775, 5494.780208791683, 4943.209086546171, 4959.132151873408, 4959.603231741452, 4967.453580106186, 4970.304157417964, 5977.641341519523, 5984.640921544721, 5992.221011268551, 5999.940000599981, 6006.099085137221, 3970.285348637244, 4073.5111786585503, 4081.632653061209, 4083.2650122977852, 4094.815733292009, 6217.6891155442045, 6237.781677641261, 6276.623402595859, 6282.246130464374, 6282.371762823726, 4176.895577610584, 4184.456020717348, 4185.97907010463, 4187.644050255702, 4189.036521600049, 4256.893577660583, 4259.488861336659, 4261.744295342228, 4264.317709166518, 4269.231538323132, 4792.976035119802, 4798.73606951621, 4854.17479028566, 4912.705237685679, 4924.76880779805, 5904.084866845646, 5908.881822363529, 5917.142014407887, 5938.881222375615, 5939.82180534576, 1496.4762333183298, 1504.8194216694067, 1511.1839606612525, 1511.3350125944548, 1512.7579587265984, 991.712403403005, 1009.2077718990557, 1009.8030883977701, 1017.4099022566893, 1027.547878933267, 5134.101532231844, 5146.87132821675, 5163.40620828602, 5164.0, 5168.689878607221, 6146.078088286793, 6167.599106058092, 6170.321264660884, 6183.288921774054, 6192.938070619326, 5130.640855140179, 5131.974340128276, 5141.820036298712, 5142.30578871855, 5142.691438513626, 3293.226091868409, 3332.8666853325594, 3349.179451034512, 3374.898753037413, 3380.6619338066, 5855.121731740188, 5856.12158176277, 5870.530357571384, 5875.29496460419, 5877.265341832271, 6467.967660161669, 6472.741090356333, 6473.8705225896165, 6478.574713563009, 6483.4164925156965, 5685.232493613309, 5849.766009359578, 5850.0932355484965, 5854.736536855852, 5871.706414679249, 6291.119243306032, 6292.150559674568, 6293.118963345227, 6301.023341382093, 6314.147590075465, 6116.480099191618, 6119.602225855305, 6128.754849805958, 6129.816105516842, 6140.140380346845, 5698.8290351289525, 5838.007538718513, 5858.765649373977, 5863.2670916135485, 5869.002269614261, 4182.644475219518, 4214.072903961123, 4218.789060547022, 4220.092680073799, 4222.155568886174, 6088.8782224356155, 6207.751689932352, 6273.466755325666, 6281.685915704288, 6287.685615719287, 6006.039033754579, 6016.217891674054, 6019.187409699634, 6035.486983606267, 6035.939640603713, 5953.493953013869, 5995.88008239824, 5996.70016499182, 6002.789902353396, 6011.6393016417405, 5692.345380281321, 5854.619449735754, 5874.530037596896, 5891.469767720926, 5900.29196496406, 6014.36849130835, 6038.426349496966, 6050.818475445743, 6058.818235452944, 6076.8784624308155, 5841.678707671119, 5908.468237858613, 5909.52723782105, 5910.143029260647, 5919.467247947533], "yui.html": [622.268834119909, 664.810528999235, 744.702119152339, 750.0, 759.0057224250332, 11442.313461192334, 11787.941060294697, 11806.0, 11840.644780656583, 11858.0, 11561.421928903543, 12769.36153192339, 12945.22328660281, 12979.935100324508, 12994.28531430771, 757.6363345594118, 764.1975925278449, 773.941954353423, 775.8874963130343, 778.5756762564416, 775.2170307988944, 776.1074764021392, 776.1462391369505, 779.0573406178531, 781.7732857471354, 791.2285521616407, 793.3573805217763, 797.2585495489193, 798.0582912163644, 802.1377019703813, 779.9259070388304, 783.2793829676683, 789.8578255913933, 791.9485233459865, 792.18405042806, 578.7222133375961, 579.3713820504757, 581.1399129288676, 583.5360888093976, 584.4914924016091, 11646.417679116095, 11846.763064738658, 11875.0499960003, 11886.940565297205, 11917.165798394115, 8574.013988391353, 8906.599203035814, 8960.01439841617, 9447.149756521878, 9719.17387022104, 8850.114988501162, 9142.314326425478, 9161.221296189766, 9235.261179105655, 9242.86135707965, 2868.942621147565, 2901.3181902252954, 2937.4125174965093, 2992.446397416485, 2998.100569829064, 38467.230655387015, 38804.22391552181, 38819.223615527815, 38885.83342499758, 39062.0, 6620.9006864897065, 6796.320367963263, 6837.692303846339, 7096.07750992378, 7196.496245262886, 10717.035466808025, 10752.086072683753, 10814.134869210444, 10844.240903136704, 10891.292066015683, 5454.209139674725, 5602.299712535933, 5727.684977326204, 5734.483896449339, 5758.827235182951, 3640.162762564625, 3661.359262129117, 3666.3400587894434, 3717.237966216919, 3718.4422336649177, 2488.14159115105, 2502.9749702503104, 2508.072013355034, 2508.184839927031, 2508.8243822932586, 400.6114069352723, 402.961718636729, 407.05766151359506, 415.9438475805788, 417.4573055028451, 456.59591261733607, 548.9953385304882, 591.5297338615725, 597.3667912013193, 601.6781022153215, 6863.485238607124, 7353.522021068614, 7489.550626962399, 7524.209957954336, 8413.537255450887, 509.31751453053084, 518.5592246590444, 532.475511621053, 585.7920438244447, 647.9870402591922, 3470.9132271692906, 3541.2740388220354, 3636.8181590920876, 3643.7449378543247, 3773.8301776420126, 54501.45498545043, 54812.17781733277, 55305.1704224437, 55406.16890746642, 55468.72265638646, 47468.76265618719, 47615.52384476111, 48047.279290810664, 48322.516774832504, 48559.27161092586, 42369.78815105966, 42386.57613423826, 42693.57306426896, 43023.56976430196, 43142.56857431385, 6779.220389655253, 6832.419244364285, 6889.655517224019, 6947.5831450113155, 7109.324614161646, 31181.68818311788, 31254.374912501167, 31469.52795708112, 31850.36299274048, 31923.680763193, 37441.251174975805, 37572.0, 39086.804565976985, 41378.586214138675, 41863.7906810464, 6924.861502770017, 7060.082189315356, 7187.1734750504365, 7252.963735181291, 7515.549067055994, 10612.416317102634, 10653.57385704563, 10681.198910081619, 10999.725006874893, 11038.613648522263, 11050.941345232808, 11079.169062320198, 11120.388378639253, 11150.665480035612, 11243.10055195566, 10451.0, 10464.895351046393, 10674.0, 10792.730181745204, 11115.11079113685, 10652.0, 10775.676729698122, 10853.0, 11142.665720028412, 11210.0, 9526.52367381642, 9683.467409292274, 9697.272704547046, 9780.41317520951, 9896.257780666334, 8382.874256886029, 8640.740777776677, 8660.610272537624, 9456.281197590508, 9601.37591056607]}, "summary": {"lowerIsBetter": false, "suite": 6062.196520515025, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6655.45763911522, "unit": "ms", "value": 6655.45763911522}, "dojo.html": {"lowerIsBetter": false, "filtered": 4758.3262161719895, "unit": "ms", "value": 4758.3262161719895}, "mootools.html": {"lowerIsBetter": false, "filtered": 3943.1845441504884, "unit": "ms", "value": 3943.1845441504884}, "ext.html": {"lowerIsBetter": false, "filtered": 16395.747763091465, "unit": "ms", "value": 16395.747763091465}, "prototype.html": {"lowerIsBetter": false, "filtered": 4456.589834510104, "unit": "ms", "value": 4456.589834510104}, "yui.html": {"lowerIsBetter": false, "filtered": 5439.0911428844975, "unit": "ms", "value": 5439.0911428844975}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-013.e"}, "testrun": {"date": 1447420227, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113044230", "branch": "Fx-Team-Non-PGO", "revision": "e68c0bbf6818f1e1128595d2012273f22770b352"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 164.0, 162.0, 163.0, 162.0, 165.0, 173.0, 163.0, 167.0, 163.0], "ai-astar": [113.0, 108.0, 112.0, 111.0, 113.0, 122.0, 113.0, 112.0, 111.0, 113.0], "imaging-gaussian-blur": [110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [157.0, 131.0, 157.0, 171.0, 141.0, 155.0, 154.0, 138.0, 171.0, 133.0], "json-stringify-tinderbox": [68.0, 67.0, 66.0, 67.0, 73.0, 68.0, 67.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [147.0, 160.0, 151.0, 147.0, 165.0, 158.0, 151.0, 146.0, 138.0, 147.0], "json-parse-financial": [73.0, 73.0, 71.0, 73.0, 73.0, 73.0, 73.0, 72.0, 74.0, 69.0], "stanford-crypto-sha256-iterative": [73.0, 72.0, 68.0, 74.0, 69.0, 68.0, 69.0, 69.0, 68.0, 70.0], "audio-fft": [73.0, 74.0, 73.0, 72.0, 74.0, 73.0, 129.0, 78.0, 73.0, 72.0], "imaging-darkroom": [151.0, 147.0, 148.0, 147.0, 148.0, 150.0, 149.0, 149.0, 148.0, 148.0], "stanford-crypto-ccm": [119.0, 121.0, 127.0, 129.0, 120.0, 135.0, 124.0, 126.0, 131.0, 133.0], "audio-oscillator": [91.0, 92.0, 131.0, 90.0, 91.0, 91.0, 132.0, 91.0, 92.0, 124.0], "stanford-crypto-aes": [86.0, 84.0, 84.0, 83.0, 86.0, 82.0, 85.0, 85.0, 85.0, 84.0], "imaging-desaturate": [95.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1536.4000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.1, "unit": "ms", "value": 79.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.0, "unit": "ms", "value": 151.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.8, "unit": "ms", "value": 150.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.5, "unit": "ms", "value": 126.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.4, "unit": "ms", "value": 72.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.5, "unit": "ms", "value": 102.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 112.8, "unit": "ms", "value": 112.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.4, "unit": "ms", "value": 164.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.0, "unit": "ms", "value": 70.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.7, "unit": "ms", "value": 67.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.4, "unit": "ms", "value": 84.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.2, "unit": "ms", "value": 96.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-013.e"}, "testrun": {"date": 1447420227, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113044230", "branch": "Fx-Team-Non-PGO", "revision": "e68c0bbf6818f1e1128595d2012273f22770b352"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.64365214110546], "Encrypt": [279.9552071668533], "NavierStokes": [4826.923076923077], "Decrypt": [5060.606060606061], "Splay": [611.9951040391677], "Richards": [163.71971185330713], "RegExp": [25974.358974358973], "Earley": [725.8883248730964], "Boyer": [11800.0], "RayTrace": [1071.8113612004288]}, "summary": {"lowerIsBetter": false, "suite": 21407.567122028027, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 350.49151800000004, "unit": "score", "value": 350.49151800000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 950.7985320000004, "unit": "score", "value": 950.7985320000004}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.59864071856286, "unit": "score", "value": 52.59864071856286}, "Splay": {"lowerIsBetter": false, "filtered": 133.15629400000003, "unit": "score", "value": 133.15629400000003}, "RegExp": {"lowerIsBetter": false, "filtered": 35.072472852912156, "unit": "score", "value": 35.072472852912156}, "Richards": {"lowerIsBetter": false, "filtered": 215.62461599999997, "unit": "score", "value": 215.62461599999997}, "Earley": {"lowerIsBetter": false, "filtered": 918.1343426573427, "unit": "score", "value": 918.1343426573427}, "Boyer": {"lowerIsBetter": false, "filtered": 56.4799152542373, "unit": "score", "value": 56.4799152542373}, "RayTrace": {"lowerIsBetter": false, "filtered": 690.4097369999998, "unit": "score", "value": 690.4097369999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-013.e"}, "testrun": {"date": 1447420227, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113044230", "branch": "Fx-Team-Non-PGO", "revision": "e68c0bbf6818f1e1128595d2012273f22770b352"}}] 05:32:26 INFO - RETURN: dromaeo_css: 6062.20 05:32:26 INFO - RETURN: kraken: 1536.40 05:32:26 INFO - RETURN: v8_7: 21407.57 05:32:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21407.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1536.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6062.20"}}} 05:32:26 INFO - Return code: 0 05:32:26 INFO - # TBPL SUCCESS # 05:32:26 INFO - Running post-action listener: _resource_record_post_action 05:32:26 INFO - Running post-run listener: _resource_record_post_run 05:32:27 INFO - Total resource usage - Wall time: 1344s; CPU: 14.0%; Read bytes: 4096; Write bytes: 495423488; Read time: 11392; Write time: 8927468 05:32:27 INFO - install - Wall time: 26s; CPU: 22.0%; Read bytes: 0; Write bytes: 151465984; Read time: 0; Write time: 1354436 05:32:27 INFO - run-tests - Wall time: 1319s; CPU: 14.0%; Read bytes: 4096; Write bytes: 334618624; Read time: 11392; Write time: 7208156 05:32:27 INFO - Running post-run listener: _upload_blobber_files 05:32:27 INFO - Blob upload gear active. 05:32:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:32:27 INFO - Copying logs to upload dir... 05:32:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1383.790429 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 3 secs) (at 2015-11-13 05:32:27.368606) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:32:27.372319) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008559 build_url: 'https://queue.taskcluster.net/v1/task/WkIEkQ0JRWSw2pzQVVDIrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:32:27.424882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:32:27.425259) ========= 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=256b35f542ca8bede9e27f1f00000291-1447420161.671521-1132667769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004730 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:32:27.475016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 05:32:27.475365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 05:32:27.475705) ========= ========= Total master_lag: 0.24 =========