builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1447555655.19 results: success (0) buildid: 20151114182033 builduid: a8929fe1a8724492a5f4c4289944ebcd revision: 0af3033225956bfc2ba52c0087dc5c9ea0ccf297 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.190482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.191195) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.191645) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006497 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.256003) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.256549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.391579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.391878) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.452229) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.452511) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.452876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.453158) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 18:47:36-- 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% 223M=0s 2015-11-14 18:47:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180036 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.649372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.649707) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015634 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.708289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:35.708643) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0af3033225956bfc2ba52c0087dc5c9ea0ccf297 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0af3033225956bfc2ba52c0087dc5c9ea0ccf297 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 18:47:36,876 truncating revision to first 12 chars 2015-11-14 18:47:36,876 Setting DEBUG logging. 2015-11-14 18:47:36,876 attempt 1/10 2015-11-14 18:47:36,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0af303322595?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 18:47:37,335 unpacking tar archive at: mozilla-inbound-0af303322595/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:36.462618) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:36.462936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:36.471941) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:36.472281) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 18:47:36.472747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-14 18:47:36.473046) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:37 INFO - MultiFileLogger online at 20151114 18:47:37 in /builds/slave/test 18:47:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 18:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:47:37 INFO - {'append_to_log': False, 18:47:37 INFO - 'base_work_dir': '/builds/slave/test', 18:47:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 18:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:47:37 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 18:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:37 INFO - 'config_files': ('talos/linux_config.py',), 18:47:37 INFO - 'default_actions': ('clobber', 18:47:37 INFO - 'read-buildbot-config', 18:47:37 INFO - 'download-and-extract', 18:47:37 INFO - 'populate-webroot', 18:47:37 INFO - 'create-virtualenv', 18:47:37 INFO - 'install', 18:47:37 INFO - 'run-tests'), 18:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:37 INFO - 'download_minidump_stackwalk': True, 18:47:37 INFO - 'download_symbols': 'ondemand', 18:47:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:37 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:37 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:37 INFO - 'installer_path': 'installer.exe', 18:47:37 INFO - 'log_level': 'info', 18:47:37 INFO - 'log_name': 'talos', 18:47:37 INFO - 'log_to_console': True, 18:47:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:37 INFO - 'opt_config_files': (), 18:47:37 INFO - 'pip_index': False, 18:47:37 INFO - 'sps_profile': False, 18:47:37 INFO - 'sps_profile_interval': 0, 18:47:37 INFO - 'suite': 'dromaeojs-e10s', 18:47:37 INFO - 'system_bits': '64', 18:47:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:37 INFO - 'title': 'talos-linux64-ix-035', 18:47:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:37 INFO - 'use_talos_json': True, 18:47:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:47:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:37 INFO - 'work_dir': 'build'} 18:47:37 INFO - ##### 18:47:37 INFO - ##### Running clobber step. 18:47:37 INFO - ##### 18:47:37 INFO - Running pre-action listener: _resource_record_pre_action 18:47:37 INFO - Running main action method: clobber 18:47:37 INFO - rmtree: /builds/slave/test/build 18:47:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:47:38 INFO - Running post-action listener: _resource_record_post_action 18:47:38 INFO - ##### 18:47:38 INFO - ##### Running read-buildbot-config step. 18:47:38 INFO - ##### 18:47:38 INFO - Running pre-action listener: _resource_record_pre_action 18:47:38 INFO - Running main action method: read_buildbot_config 18:47:38 INFO - Using buildbot properties: 18:47:38 INFO - { 18:47:38 INFO - "properties": { 18:47:38 INFO - "buildnumber": 2605, 18:47:38 INFO - "product": "firefox", 18:47:38 INFO - "script_repo_revision": "production", 18:47:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:47:38 INFO - "repository": "", 18:47:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 18:47:38 INFO - "buildid": "20151114182033", 18:47:38 INFO - "slavename": "talos-linux64-ix-035", 18:47:38 INFO - "pgo_build": "False", 18:47:38 INFO - "basedir": "/builds/slave/test", 18:47:38 INFO - "project": "", 18:47:38 INFO - "platform": "ubuntu64_hw", 18:47:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:47:38 INFO - "slavebuilddir": "test", 18:47:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 18:47:38 INFO - "branch": "mozilla-inbound", 18:47:38 INFO - "repo_path": "integration/mozilla-inbound", 18:47:38 INFO - "stage_platform": "linux64", 18:47:38 INFO - "builduid": "a8929fe1a8724492a5f4c4289944ebcd", 18:47:38 INFO - "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297" 18:47:38 INFO - }, 18:47:38 INFO - "sourcestamp": { 18:47:38 INFO - "repository": "", 18:47:38 INFO - "hasPatch": false, 18:47:38 INFO - "project": "", 18:47:38 INFO - "branch": "mozilla-inbound-linux64-talos", 18:47:38 INFO - "changes": [ 18:47:38 INFO - { 18:47:38 INFO - "category": null, 18:47:38 INFO - "files": [ 18:47:38 INFO - { 18:47:38 INFO - "url": null, 18:47:38 INFO - "name": "https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:47:38 INFO - } 18:47:38 INFO - ], 18:47:38 INFO - "repository": "", 18:47:38 INFO - "rev": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297", 18:47:38 INFO - "who": "philringnalda@gmail.com", 18:47:38 INFO - "when": 1447555577, 18:47:38 INFO - "number": 6662921, 18:47:38 INFO - "comments": "Bug 774689 - Mark 632781-verybig.html random-if on OS X 10.10 for too many intermittent failures", 18:47:38 INFO - "project": "", 18:47:38 INFO - "at": "Sat 14 Nov 2015 18:46:17", 18:47:38 INFO - "branch": "mozilla-inbound-linux64-talos", 18:47:38 INFO - "revlink": "", 18:47:38 INFO - "properties": [ 18:47:38 INFO - [ 18:47:38 INFO - "buildid", 18:47:38 INFO - "20151114182033", 18:47:38 INFO - "Change" 18:47:38 INFO - ], 18:47:38 INFO - [ 18:47:38 INFO - "builduid", 18:47:38 INFO - "a8929fe1a8724492a5f4c4289944ebcd", 18:47:38 INFO - "Change" 18:47:38 INFO - ], 18:47:38 INFO - [ 18:47:38 INFO - "pgo_build", 18:47:38 INFO - "False", 18:47:38 INFO - "Change" 18:47:38 INFO - ] 18:47:38 INFO - ], 18:47:38 INFO - "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297" 18:47:38 INFO - } 18:47:38 INFO - ], 18:47:38 INFO - "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297" 18:47:38 INFO - } 18:47:38 INFO - } 18:47:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:47:38 INFO - Running post-action listener: _resource_record_post_action 18:47:38 INFO - ##### 18:47:38 INFO - ##### Running download-and-extract step. 18:47:38 INFO - ##### 18:47:38 INFO - Running pre-action listener: _resource_record_pre_action 18:47:38 INFO - Running main action method: download_and_extract 18:47:38 INFO - mkdir: /builds/slave/test/build/tests 18:47:38 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')]} 18:47:38 INFO - https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/test_packages.json 18:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/test_packages.json 18:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:47:41 INFO - Downloaded 1302 bytes. 18:47:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:47:41 INFO - Using the following test package requirements: 18:47:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'jsshell-linux-x86_64.zip'], 18:47:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:41 INFO - https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:43 INFO - Downloaded 21278031 bytes. 18:47:43 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 18:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:43 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 18:47:44 INFO - Return code: 0 18:47:44 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 18:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:47:44 INFO - https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:52 INFO - Downloaded 21278031 bytes. 18:47:52 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 18:47:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:47:52 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 18:47:53 INFO - Return code: 0 18:47:53 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')]} 18:47:53 INFO - https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:54 INFO - Downloaded 11131693 bytes. 18:47:54 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 18:47:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:54 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 18:47:54 INFO - Return code: 0 18:47: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')]} 18:47:54 INFO - https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d056YPDPSROGwlKXGcyHbQ/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 18:47:55 INFO - Downloaded 55598002 bytes. 18:47:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:47:55 INFO - mkdir: /builds/slave/test/properties 18:47:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:47:55 INFO - Writing to file /builds/slave/test/properties/build_url 18:47:55 INFO - Contents: 18:47:55 INFO - build_url:https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:47:55 INFO - Running post-action listener: _resource_record_post_action 18:47:55 INFO - Running post-action listener: set_extra_try_arguments 18:47:55 INFO - ##### 18:47:55 INFO - ##### Running populate-webroot step. 18:47:55 INFO - ##### 18:47:55 INFO - Running pre-action listener: _resource_record_pre_action 18:47:55 INFO - Running main action method: populate_webroot 18:47:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:47:55 INFO - '../fennec_ids.txt'], 18:47:55 INFO - 'tests': ['tcheck2']}, 18:47:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:55 INFO - '--tppagecycles', 18:47:55 INFO - '7'], 18:47:55 INFO - 'tests': ['tsvgm']}}, 18:47:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:47:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'tests': ['damp', 'tps']}, 18:47:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['damp', 'tps']}, 18:47:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:47:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:55 INFO - 'other': {'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'other_l64': {'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'other_nol64': {'tests': ['a11yr', 18:47:55 INFO - 'ts_paint', 18:47:55 INFO - 'tpaint', 18:47:55 INFO - 'sessionrestore', 18:47:55 INFO - 'sessionrestore_no_auto_restore']}, 18:47:55 INFO - 'svgr': {'tests': ['tsvgx', 18:47:55 INFO - 'tsvgr_opacity', 18:47:55 INFO - 'tart', 18:47:55 INFO - 'tscrollx', 18:47:55 INFO - 'cart']}, 18:47:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['tsvgx', 18:47:55 INFO - 'tsvgr_opacity', 18:47:55 INFO - 'tart', 18:47:55 INFO - 'tscrollx', 18:47:55 INFO - 'cart']}, 18:47:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'tests': ['tp5o']}, 18:47:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'talos_options': ['--e10s'], 18:47:55 INFO - 'tests': ['tp5o']}, 18:47:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'talos_options': ['--xperf_path', 18:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:55 INFO - 'tests': ['tp5n']}, 18:47:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:55 INFO - 'talos_options': ['--e10s', 18:47:55 INFO - '--xperf_path', 18:47:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:55 INFO - 'tests': ['tp5n']}}, 18:47:55 INFO - 'talos.zip': {'path': '', 18:47:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:55 INFO - Running post-action listener: _resource_record_post_action 18:47:55 INFO - ##### 18:47:55 INFO - ##### Running create-virtualenv step. 18:47:55 INFO - ##### 18:47:55 INFO - Running pre-action listener: _resource_record_pre_action 18:47:55 INFO - Running main action method: create_virtualenv 18:47:55 INFO - Creating virtualenv /builds/slave/test/build/venv 18:47:55 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 18:47:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:56 INFO - Using real prefix '/usr' 18:47:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:47:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:58 INFO - Installing pip.................done. 18:47:58 INFO - Return code: 0 18:47:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:58 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:47:58 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 18:47:58 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 18:47:58 INFO - Using env: {'DISPLAY': ':0', 18:47:58 INFO - 'HOME': '/home/cltbld', 18:47:58 INFO - 'LANG': 'en_US.UTF-8', 18:47:58 INFO - 'LANGUAGE': 'en_US:en', 18:47:58 INFO - 'LOGNAME': 'cltbld', 18:47:58 INFO - 'MAIL': '/var/mail/cltbld', 18:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:58 INFO - 'MOZ_NO_REMOTE': '1', 18:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:58 INFO - 'NO_EM_RESTART': '1', 18:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:58 INFO - 'PWD': '/builds/slave/test', 18:47:58 INFO - 'SHELL': '/bin/bash', 18:47:58 INFO - 'SHLVL': '1', 18:47:58 INFO - 'TERM': 'linux', 18:47:58 INFO - 'TMOUT': '86400', 18:47:58 INFO - 'USER': 'cltbld', 18:47:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:58 INFO - '_': '/tools/buildbot/bin/python'} 18:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:47:58 INFO - Cleaning up... 18:47:58 INFO - Return code: 0 18:47:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:58 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:47:58 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 18:47:58 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 18:47:58 INFO - Using env: {'DISPLAY': ':0', 18:47:58 INFO - 'HOME': '/home/cltbld', 18:47:58 INFO - 'LANG': 'en_US.UTF-8', 18:47:58 INFO - 'LANGUAGE': 'en_US:en', 18:47:58 INFO - 'LOGNAME': 'cltbld', 18:47:58 INFO - 'MAIL': '/var/mail/cltbld', 18:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:58 INFO - 'MOZ_NO_REMOTE': '1', 18:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:58 INFO - 'NO_EM_RESTART': '1', 18:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:58 INFO - 'PWD': '/builds/slave/test', 18:47:58 INFO - 'SHELL': '/bin/bash', 18:47:58 INFO - 'SHLVL': '1', 18:47:58 INFO - 'TERM': 'linux', 18:47:58 INFO - 'TMOUT': '86400', 18:47:58 INFO - 'USER': 'cltbld', 18:47:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:58 INFO - '_': '/tools/buildbot/bin/python'} 18:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:59 INFO - Downloading/unpacking psutil>=0.7.1 18:47:59 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 18:47:59 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 18:47:59 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 18:47:59 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 18:47:59 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 18:47:59 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 18:48:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:00 INFO - Installing collected packages: psutil 18:48:00 INFO - Running setup.py install for psutil 18:48:00 INFO - building 'psutil._psutil_linux' extension 18:48:00 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 18:48:01 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 18:48:01 INFO - building 'psutil._psutil_posix' extension 18:48:01 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 18:48:01 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 18:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:01 INFO - Successfully installed psutil 18:48:01 INFO - Cleaning up... 18:48:01 INFO - Return code: 0 18:48:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:01 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:48:01 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 18:48:01 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 18:48:01 INFO - Using env: {'DISPLAY': ':0', 18:48:01 INFO - 'HOME': '/home/cltbld', 18:48:01 INFO - 'LANG': 'en_US.UTF-8', 18:48:01 INFO - 'LANGUAGE': 'en_US:en', 18:48:01 INFO - 'LOGNAME': 'cltbld', 18:48:01 INFO - 'MAIL': '/var/mail/cltbld', 18:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:01 INFO - 'MOZ_NO_REMOTE': '1', 18:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:01 INFO - 'NO_EM_RESTART': '1', 18:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:01 INFO - 'PWD': '/builds/slave/test', 18:48:01 INFO - 'SHELL': '/bin/bash', 18:48:01 INFO - 'SHLVL': '1', 18:48:01 INFO - 'TERM': 'linux', 18:48:01 INFO - 'TMOUT': '86400', 18:48:01 INFO - 'USER': 'cltbld', 18:48:01 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:01 INFO - '_': '/tools/buildbot/bin/python'} 18:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:48:03 INFO - Installing collected packages: mozsystemmonitor 18:48:03 INFO - Running setup.py install for mozsystemmonitor 18:48:03 INFO - Successfully installed mozsystemmonitor 18:48:03 INFO - Cleaning up... 18:48:03 INFO - Return code: 0 18:48:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:03 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:48:03 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 18:48:03 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 18:48:03 INFO - Using env: {'DISPLAY': ':0', 18:48:03 INFO - 'HOME': '/home/cltbld', 18:48:03 INFO - 'LANG': 'en_US.UTF-8', 18:48:03 INFO - 'LANGUAGE': 'en_US:en', 18:48:03 INFO - 'LOGNAME': 'cltbld', 18:48:03 INFO - 'MAIL': '/var/mail/cltbld', 18:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:03 INFO - 'MOZ_NO_REMOTE': '1', 18:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:03 INFO - 'NO_EM_RESTART': '1', 18:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:03 INFO - 'PWD': '/builds/slave/test', 18:48:03 INFO - 'SHELL': '/bin/bash', 18:48:03 INFO - 'SHLVL': '1', 18:48:03 INFO - 'TERM': 'linux', 18:48:03 INFO - 'TMOUT': '86400', 18:48:03 INFO - 'USER': 'cltbld', 18:48:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:03 INFO - '_': '/tools/buildbot/bin/python'} 18:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:48:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 INFO - Downloading docopt-0.6.1.tar.gz 18:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:05 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:05 INFO - Running setup.py install for blobuploader 18:48:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:48:06 INFO - Running setup.py install for requests 18:48:06 INFO - Running setup.py install for docopt 18:48:06 INFO - Successfully installed blobuploader requests docopt 18:48:06 INFO - Cleaning up... 18:48:06 INFO - Return code: 0 18:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:48:06 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 18:48:06 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 18:48:06 INFO - Using env: {'DISPLAY': ':0', 18:48:06 INFO - 'HOME': '/home/cltbld', 18:48:06 INFO - 'LANG': 'en_US.UTF-8', 18:48:06 INFO - 'LANGUAGE': 'en_US:en', 18:48:06 INFO - 'LOGNAME': 'cltbld', 18:48:06 INFO - 'MAIL': '/var/mail/cltbld', 18:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:06 INFO - 'MOZ_NO_REMOTE': '1', 18:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:06 INFO - 'NO_EM_RESTART': '1', 18:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:06 INFO - 'PWD': '/builds/slave/test', 18:48:06 INFO - 'SHELL': '/bin/bash', 18:48:06 INFO - 'SHLVL': '1', 18:48:06 INFO - 'TERM': 'linux', 18:48:06 INFO - 'TMOUT': '86400', 18:48:06 INFO - 'USER': 'cltbld', 18:48:06 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:06 INFO - '_': '/tools/buildbot/bin/python'} 18:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:06 INFO - Running setup.py (path:/tmp/pip-wJAK9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:06 INFO - Running setup.py (path:/tmp/pip-XRZKXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:06 INFO - Running setup.py (path:/tmp/pip-yy43EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:06 INFO - Running setup.py (path:/tmp/pip-gQCN_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:07 INFO - Running setup.py (path:/tmp/pip-xFaHKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:07 INFO - Running setup.py (path:/tmp/pip-IRFPNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:07 INFO - Running setup.py (path:/tmp/pip-09nUpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:07 INFO - Running setup.py (path:/tmp/pip-GSkekL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:07 INFO - Running setup.py (path:/tmp/pip-SQOWCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:07 INFO - Running setup.py (path:/tmp/pip-0fxf6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:07 INFO - Running setup.py (path:/tmp/pip-FNiRkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:07 INFO - Running setup.py (path:/tmp/pip-TguH8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:07 INFO - Running setup.py (path:/tmp/pip-dQOGxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:07 INFO - Running setup.py (path:/tmp/pip-zhBA1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:07 INFO - Running setup.py (path:/tmp/pip-HYFtbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:07 INFO - Running setup.py (path:/tmp/pip-OlioIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:07 INFO - Running setup.py (path:/tmp/pip-pXqAVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:07 INFO - Running setup.py install for manifestparser 18:48:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for mozcrash 18:48:08 INFO - Running setup.py install for mozdebug 18:48:08 INFO - Running setup.py install for mozdevice 18:48:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for mozfile 18:48:08 INFO - Running setup.py install for mozhttpd 18:48:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for mozinfo 18:48:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for mozInstall 18:48:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for mozleak 18:48:08 INFO - Running setup.py install for mozlog 18:48:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:48:08 INFO - Running setup.py install for moznetwork 18:48:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Running setup.py install for mozprocess 18:48:09 INFO - Running setup.py install for mozprofile 18:48:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Running setup.py install for mozrunner 18:48:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Running setup.py install for mozscreenshot 18:48:09 INFO - Running setup.py install for moztest 18:48:09 INFO - Running setup.py install for mozversion 18:48:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:48:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:09 INFO - Cleaning up... 18:48:09 INFO - Return code: 0 18:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:09 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')]} 18:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:09 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')]} 18:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:09 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:48:09 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 18:48:09 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 18:48:09 INFO - Using env: {'DISPLAY': ':0', 18:48:09 INFO - 'HOME': '/home/cltbld', 18:48:09 INFO - 'LANG': 'en_US.UTF-8', 18:48:09 INFO - 'LANGUAGE': 'en_US:en', 18:48:09 INFO - 'LOGNAME': 'cltbld', 18:48:09 INFO - 'MAIL': '/var/mail/cltbld', 18:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:09 INFO - 'MOZ_NO_REMOTE': '1', 18:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:09 INFO - 'NO_EM_RESTART': '1', 18:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:09 INFO - 'PWD': '/builds/slave/test', 18:48:09 INFO - 'SHELL': '/bin/bash', 18:48:09 INFO - 'SHLVL': '1', 18:48:09 INFO - 'TERM': 'linux', 18:48:09 INFO - 'TMOUT': '86400', 18:48:09 INFO - 'USER': 'cltbld', 18:48:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:09 INFO - '_': '/tools/buildbot/bin/python'} 18:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:09 INFO - Running setup.py (path:/tmp/pip-IyCbTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:10 INFO - Running setup.py (path:/tmp/pip-hoffky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:10 INFO - Running setup.py (path:/tmp/pip-SCN1h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:10 INFO - Running setup.py (path:/tmp/pip-pdbT2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:10 INFO - Running setup.py (path:/tmp/pip-jGefnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:10 INFO - Running setup.py (path:/tmp/pip-fESBaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:10 INFO - Running setup.py (path:/tmp/pip-_L2dZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:10 INFO - Running setup.py (path:/tmp/pip-RRnvyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:10 INFO - Running setup.py (path:/tmp/pip-zIaygG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:10 INFO - Running setup.py (path:/tmp/pip-U2DSSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:10 INFO - Running setup.py (path:/tmp/pip-Ls1Ukn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:10 INFO - Running setup.py (path:/tmp/pip-WB43mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:10 INFO - Running setup.py (path:/tmp/pip-2PnA7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:10 INFO - Running setup.py (path:/tmp/pip-MQJp2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:10 INFO - Running setup.py (path:/tmp/pip-HOREYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:11 INFO - Running setup.py (path:/tmp/pip-seVvTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:11 INFO - Running setup.py (path:/tmp/pip-4Rkphu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:48:11 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 18:48:11 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 18:48:11 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 18:48:11 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 18:48:11 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 18:48:11 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 18:48:12 INFO - Downloading blessings-1.5.1.tar.gz 18:48:12 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 18:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:12 INFO - Installing collected packages: blessings 18:48:12 INFO - Running setup.py install for blessings 18:48:13 INFO - Successfully installed blessings 18:48:13 INFO - Cleaning up... 18:48:13 INFO - Return code: 0 18:48:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:13 INFO - Reading from file tmpfile_stdout 18:48:13 INFO - Current package versions: 18:48:13 INFO - argparse == 1.2.1 18:48:13 INFO - blessings == 1.5.1 18:48:13 INFO - blobuploader == 1.2.4 18:48:13 INFO - docopt == 0.6.1 18:48:13 INFO - manifestparser == 1.1 18:48:13 INFO - mozInstall == 1.12 18:48:13 INFO - mozcrash == 0.16 18:48:13 INFO - mozdebug == 0.1 18:48:13 INFO - mozdevice == 0.47 18:48:13 INFO - mozfile == 1.2 18:48:13 INFO - mozhttpd == 0.7 18:48:13 INFO - mozinfo == 0.9 18:48:13 INFO - mozleak == 0.1 18:48:13 INFO - mozlog == 3.0 18:48:13 INFO - moznetwork == 0.27 18:48:13 INFO - mozprocess == 0.22 18:48:13 INFO - mozprofile == 0.27 18:48:13 INFO - mozrunner == 6.11 18:48:13 INFO - mozscreenshot == 0.1 18:48:13 INFO - mozsystemmonitor == 0.0 18:48:13 INFO - moztest == 0.7 18:48:13 INFO - mozversion == 1.4 18:48:13 INFO - psutil == 3.1.1 18:48:13 INFO - requests == 1.2.3 18:48:13 INFO - wsgiref == 0.1.2 18:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:13 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 0x7f4a5cf4bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f896c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', '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 18:48:13 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 18:48:13 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 18:48:13 INFO - Using env: {'DISPLAY': ':0', 18:48:13 INFO - 'HOME': '/home/cltbld', 18:48:13 INFO - 'LANG': 'en_US.UTF-8', 18:48:13 INFO - 'LANGUAGE': 'en_US:en', 18:48:13 INFO - 'LOGNAME': 'cltbld', 18:48:13 INFO - 'MAIL': '/var/mail/cltbld', 18:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:13 INFO - 'MOZ_NO_REMOTE': '1', 18:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:13 INFO - 'NO_EM_RESTART': '1', 18:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:13 INFO - 'PWD': '/builds/slave/test', 18:48:13 INFO - 'SHELL': '/bin/bash', 18:48:13 INFO - 'SHLVL': '1', 18:48:13 INFO - 'TERM': 'linux', 18:48:13 INFO - 'TMOUT': '86400', 18:48:13 INFO - 'USER': 'cltbld', 18:48:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:13 INFO - '_': '/tools/buildbot/bin/python'} 18:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 INFO - Cleaning up... 18:48:13 INFO - Return code: 0 18:48:13 INFO - Running post-action listener: _resource_record_post_action 18:48:13 INFO - Running post-action listener: _start_resource_monitoring 18:48:13 INFO - Starting resource monitoring. 18:48:13 INFO - ##### 18:48:13 INFO - ##### Running install step. 18:48:13 INFO - ##### 18:48:13 INFO - Running pre-action listener: _resource_record_pre_action 18:48:13 INFO - Running main action method: install 18:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:13 INFO - Reading from file tmpfile_stdout 18:48:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:48:13 INFO - Reading from file tmpfile_stdout 18:48:13 INFO - Output received: 18:48:13 INFO - Usage: mozinstall [options] installer 18:48:13 INFO - Options: 18:48:13 INFO - -h, --help show this help message and exit 18:48:13 INFO - -d DEST, --destination=DEST 18:48:13 INFO - Directory to install application into. [default: 18:48:13 INFO - "/builds/slave/test"] 18:48:13 INFO - --app=APP Application being installed. [default: firefox] 18:48:13 INFO - mkdir: /builds/slave/test/build/application 18:48:13 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'] 18:48:13 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 18:48:27 INFO - Reading from file tmpfile_stdout 18:48:27 INFO - Output received: 18:48:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:48:27 INFO - Running post-action listener: _resource_record_post_action 18:48:27 INFO - ##### 18:48:27 INFO - ##### Running run-tests step. 18:48:27 INFO - ##### 18:48:27 INFO - Running pre-action listener: _resource_record_pre_action 18:48:27 INFO - Running main action method: run_tests 18:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:48:27 INFO - Python 2.7.3 18:48:27 INFO - Return code: 0 18:48:27 INFO - grabbing minidump binary from tooltool 18:48:27 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')]} 18:48:27 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 0x20c9ac0>, '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 0x20ca9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20cae50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:48:27 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 18:48:27 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 18:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:27 INFO - Return code: 0 18:48:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:48:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 18:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 18:48:27 INFO - Using env: {'DISPLAY': ':0', 18:48:27 INFO - 'HOME': '/home/cltbld', 18:48:27 INFO - 'LANG': 'en_US.UTF-8', 18:48:27 INFO - 'LANGUAGE': 'en_US:en', 18:48:27 INFO - 'LOGNAME': 'cltbld', 18:48:27 INFO - 'MAIL': '/var/mail/cltbld', 18:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:27 INFO - 'MOZ_NO_REMOTE': '1', 18:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:27 INFO - 'NO_EM_RESTART': '1', 18:48:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:27 INFO - 'PWD': '/builds/slave/test', 18:48:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:48:27 INFO - 'SHELL': '/bin/bash', 18:48:27 INFO - 'SHLVL': '1', 18:48:27 INFO - 'TERM': 'linux', 18:48:27 INFO - 'TMOUT': '86400', 18:48:27 INFO - 'USER': 'cltbld', 18:48:27 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468', 18:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:27 INFO - '_': '/tools/buildbot/bin/python'} 18:48:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 18:48:28 INFO - mozversion INFO | application_buildid: 20151114182033 18:48:28 INFO - mozversion INFO | application_changeset: 0af3033225956bfc2ba52c0087dc5c9ea0ccf297 18:48:28 INFO - mozversion INFO | application_display_name: Nightly 18:48:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:28 INFO - mozversion INFO | application_name: Firefox 18:48:28 INFO - mozversion INFO | application_remotingname: firefox 18:48:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion INFO | application_vendor: Mozilla 18:48:28 INFO - mozversion INFO | application_version: 45.0a1 18:48:28 INFO - mozversion INFO | platform_buildid: 20151114182033 18:48:28 INFO - mozversion INFO | platform_changeset: 0af3033225956bfc2ba52c0087dc5c9ea0ccf297 18:48:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:28 INFO - mozversion INFO | platform_version: 45.0a1 18:48:28 INFO - 2015-11-14 18:48:28,112 DEBUG : using testdate: 1447555708 18:48:28 INFO - 2015-11-14 18:48:28,112 DEBUG : actual date: 1447555708 18:48:28 INFO - 2015-11-14 18:48:28,194 INFO : starting webserver on 'localhost:47938' 18:48:28 INFO - 2015-11-14 18:48:28,195 INFO : Starting test suite talos-linux64-ix-035.e 18:48:28 INFO - 2015-11-14 18:48:28,195 INFO : Starting test dromaeo_css 18:48:28 INFO - 2015-11-14 18:48:28,195 DEBUG : operating with platform_type : linux_ 18:48:28 INFO - 2015-11-14 18:48:28,196 INFO : Initialising browser for dromaeo_css test... 18:48:28 INFO - 2015-11-14 18:48:28,212 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7MSVTw/profile http://localhost:47938/getInfo.html 18:48:33 INFO - 2015-11-14 18:48:33,586 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:48:33 INFO - 2015-11-14 18:48:33,586 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:48:33 INFO - 2015-11-14 18:48:33,586 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:48:33 INFO - 2015-11-14 18:48:33,587 DEBUG : BROWSER_OUTPUT: __metrics 18:48:34 INFO - 2015-11-14 18:48:34,727 INFO : Browser initialized. 18:48:34 INFO - 2015-11-14 18:48:34,727 INFO : Running cycle 1/1 for dromaeo_css test... 18:48:34 INFO - 2015-11-14 18:48:34,727 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7MSVTw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:48:46 INFO - 2015-11-14 18:48:46,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 141197312 18:48:46 INFO - 2015-11-14 18:48:46,655 DEBUG : BROWSER_OUTPUT: 18:49:36 INFO - 2015-11-14 18:49:36,296 DEBUG : BROWSER_OUTPUT: 1447555776295 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] 18:51:48 INFO - 2015-11-14 18:51:48,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47938/tests/dromaeo/cssquery-ext.html) 18:51:49 INFO - 2015-11-14 18:51:49,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 144072704 18:51:49 INFO - 2015-11-14 18:51:49,276 DEBUG : BROWSER_OUTPUT: 18:54:51 INFO - 2015-11-14 18:54:51,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-ext.html (next: http://localhost:47938/tests/dromaeo/cssquery-jquery.html) 18:54:51 INFO - 2015-11-14 18:54:51,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 143179776 18:54:51 INFO - 2015-11-14 18:54:51,795 DEBUG : BROWSER_OUTPUT: 18:57:53 INFO - 2015-11-14 18:57:53,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47938/tests/dromaeo/cssquery-mootools.html) 18:57:54 INFO - 2015-11-14 18:57:54,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 141021184 18:57:54 INFO - 2015-11-14 18:57:54,190 DEBUG : BROWSER_OUTPUT: 19:00:55 INFO - 2015-11-14 19:00:55,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47938/tests/dromaeo/cssquery-prototype.html) 19:00:56 INFO - 2015-11-14 19:00:56,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 140423168 19:00:56 INFO - 2015-11-14 19:00:56,552 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-14 19:03:59,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47938/tests/dromaeo/cssquery-yui.html) 19:03:59 INFO - 2015-11-14 19:03:59,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 19:03:59 INFO - 2015-11-14 19:03:59,665 DEBUG : BROWSER_OUTPUT: 19:07:01 INFO - 2015-11-14 19:07:01,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/dromaeo/cssquery-yui.html (next: http://localhost:47938/tests/dromaeo/cssquery-dojo.html) 19:07:02 INFO - 2015-11-14 19:07:02,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 143585280 19:07:02 INFO - 2015-11-14 19:07:02,066 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,067 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:07:02 INFO - 2015-11-14 19:07:02,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:07:02 INFO - 2015-11-14 19:07:02,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:07:02 INFO - 2015-11-14 19:07:02,067 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:07:02 INFO - 2015-11-14 19:07:02,069 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2684.342336127649;2751.5184842652557;2781.151748716642;2788.9860550697244;2793.4273473937833;4706.22347312693;4794.161021821181;4846.539578740023;4867.123917694814;4892.779824907879;4823.180059389903;4859.951400485994;4885.1695211813985;4940.086084074449;4953.083679519292;4425.8450954216605;4466.374707540939;4579.198640237945;4586.334981427691;4603.332516785064;4358.259095953696;4570.702904311226;4580.129775342691;4633.652476064309;4684.156851766681;4453.087117141011;4486.910261794778;4492.0791237796175;4530.77346132692;4564.4522657281;4534.070515544306;4555.339475776027;4566.06395688883;4574.61115805157;4580.885477863047;4289.978550107261;4549.226631472658;4557.0430209656015;4567.748773817439;4570.382998295254;4658.487566367697;4753.215719406294;4762.1666208413735;4811.951880481185;4842.2736589511505;5294.205869119624;5294.205869119624;5300.787968481256;5310.44240354761;5338.759755810997;5106.106431374495;5318.601104917147;5320.068987927136;5331.680099194061;5338.359396872362;4812.494688057774;4889.779959901813;4895.510448955147;4915.87710307238;4955.1823949048;5406.702631355234;5435.945640543623;5458.235846981426;5480.314960629921;5530.2810634618045;5031.698098114125;5173.456787037382;5212.478752124833;5221.843344699589;5226.92159617606;5167.741612919339;5169.81905633301;5200.933808569234;5223.555997740159;5264.05247055526;5227.294315267391;5227.712475813791;5235.900460903177;5236.842894713165;5273.34083239595;4908.656394052454;5013.949860501349;5060.746962651852;5189.299444574934;5201.973990130101;4382;4390.297552391602;4400.801963911632;4404.163208990281;4458.019235768126;3845.5000849889893;3852.4221366794645;3859.3439115350457;3866.574676785551;3891.9610803892165;4361.996740749645;4471.7987690554;4533.365328853963;4588.862334129982;4667.813287468532;5353.892922141613;5373.086575282133;5374.167004114369;5377.919331210035;5395.487428694268;4622.583967442946;4629.606483448944;4633.9536604634195;4650.348951146842;4664.183767840615;4521.977390113028;4610.746408947473;4642.4661163966575;4685.625149988061;4716.151092803259;5022.89954200914;5025.39695236574;5041;5059.114654935445;5082.593392528515;5104.795808167632;5310.442403547727;5323.520883120537;5330.200469929541;5330.387005494418;4941.160002799461;4947.208446648519;5043.117454445531;5068.518490743373;5076.289319495199;5236.764345604381;5248.501392367872;5261.579073674174;5264.710440925785;5286.550643195372;5077.492250774893;5215.530602245816;5285.445028271976;5311.521963023347;5336.919946200887;5024.84925452237;5081.517255860687;5088.033273677989;5121.283020377075;5151.6908985461;5113.184277530224;5134.76893539799;5136.5377116059735;5143.8456846294675;5178.197379406198;4746.145693775154;4842.443119041355;4928.162212423825;5039.067772462106;5048.1165795984825;5194.194899790538;5203.063448579292;5204.453532379046;5205.609579281493;5207.192885102815;5070.6957582545165;5081.136206844919;5081.441041485507;5093.923591146062;5134.229865520202 19:07:02 INFO - 2015-11-14 19:07:02,072 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.3252797850611;561.3516388571201;577.6332029161484;580.1906340654787;582.7057336045298;28101.29746756332;37189.25621487572;37604.81197594008;37682.623173768254;37813.62186378135;40790.59209407905;41154;41216.58783412165;41290.793546032226;41344.58655413445;7861.960690196541;7969.561674107922;8016.799580010517;8066.878996815052;8079.676812927476;7899.6050197490185;7912.367010639164;7989.760307190764;8022.318102961255;8024.67901283948;7808.414368922326;8019.398545109111;8048.275655191032;8048.557329346883;8058.5567793771315;7914.643841027168;7962.562059086719;7988.201179882023;8018.0779210390965;8037.678492860278;7878.645460954271;7993.720219792338;7996.400269979775;8005.719799806979;8051.0741264754715;37552;37886;38095.42856857149;38202.23595528074;38248;2918.0953904289527;2941.8381988990595;2950.085473503221;3041.422129795332;3065.9693403065908;28744.71255287441;29076;29154.708452915413;29625.259368515744;30156.54765178524;3094.706002929718;3127.3432579158402;3139.3407384449292;3193.6486986431473;3200.2639392939755;219474;222364;222872;223452;223511.99999999837;39504;40256.59743402587;40269.19461610751;58483;59372.7031364849;42787.7860610695;42802.57197428048;42925;43013.56986430095;43081;12598.622041338775;12711.745765084646;12739.936300318439;12791.680207994688;12813.615591532269;9589.904100958902;9641.903580964101;9672.984336644691;9763.560639771227;9784.706458806248;13941;14034.087784293988;14062.15627062359;14100.576982690536;14161.079529830527;5649.71751412436;5846.6784326862435;5856.707164641751;5883.676397798076;5969.910451343233;777.1102088109084;809.461707964209;828.5235989306173;847.326375531454;895.3016647015338;27174.5923811143;27485.31286717808;27853.16440506788;27944;28338.858305708338;876.0669886570909;918.2424499787702;951.0917074194128;981.2640519610293;985.9654912078042;14179.432822687184;14188.432462701583;14920.925395373171;14980.40078396852;15239.23803809805;329848;332065;333988;334498;336363;48952;49863;49899.75050124726;49901.750491248036;50138.74930625324;1176.4647085576041;1181.3384504677408;1188.3998580716682;1194.6296648039308;1198.1852340408432;28217;28501;28850.422991540472;28988.42023159567;29314.267143320736;42383.7880810594;43028.78485607552;43145.784271078446;43445;43529;197027;198457;199102;199243;199433;36235.637643623224;43555;43688.56311436972;44337.334939975284;44407.77796111128;40507.18985620212;40607.593924060384;40801.1839763209;40804.144498457885;41087.794561027;34955;35088.47367289442;35290.47064294089;38250.808745957205;39601;35258;35313;39778.403323949584;40007.79996100001;40028;34138.14654633654;34338.656613433544;34351;34637.82681086579;34895.82552087223;30336.241593960327;31293.687063129077;31628;31713.524297136024;32151.19622009375;24302.51394972126;24489.142879999115;24574.877125614257;24637.630435543124;24840.25479235626 19:07:02 INFO - 2015-11-14 19:07:02,073 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.64348325550026;332.6191510720225;338.9406853800586;340.09365042162636;345.1010118640942;11300.491477883494;11780.705482362924;15126.546203613896;15165.848341516596;17193.398231061914;10212.438315892623;10249.43628100456;10825.945870270658;10887;11151.776964460705;4201.936970945439;4305.880471077511;4308.849190278341;4325.632321252698;4331.112122014995;4237.110206856564;4313.331433627777;4337.327714204288;4346.087321662455;4351.782410879443;4287.678424118204;4300;4489.483709373415;4565.748883811389;4586.4266966629175;4555.293929440909;4611.861644150664;4618.1687296286655;4621.537846215385;4634.189016922042;3938.547067087293;4040.5959404059654;4044.2518134144984;4046.8583599574167;4048.7570745755347;11291.774164516746;11374.772504549863;11536.423178841109;11634.59278925242;11636.883631163664;1686.5109118355663;1754.7280171573427;1760.313477743681;1771.8582513399026;1869.5793446474433;9430.622775088988;9526.618935242583;9643.951780241054;9782.9510852446;9815;1687.8902871313326;1691.5686499942435;1804.3414153833755;1843.4930394141584;1871.0738184598574;52812;54022.45977540214;54102;54401.72799136019;54844.17733733997;6356.410897275681;6368.267649220306;6389.3291204423795;6764.120664313607;6774.695138718769;7238.819029524304;7254.673539690727;7254.782356529313;7258.745943891939;7329;5024;5033.471485494044;5057.393112826484;5078.21287700407;5105;5119.564836988823;5193.2989046479;5198.16829307309;5198.6880787152895;5215.191645294985;3090.4128215639407;3134.1381120191672;3144.0567829651013;3145.685431456836;3160.1625569224175;1086.4676308608725;1092.071739021841;1093.8195197792434;1109.6504601050804;1168.4041139019162;358.6341931230183;360.9404448266059;366.53633154060134;373.5610657477507;433.3240145373228;8059.113497515269;8649.56752162402;8745.256653184424;8791.824163516694;8935.28517718581;380.216753487816;381.55548785664945;386.8278616015902;450.6012179221347;461.3656222693796;5785.334686511021;5892.086726557391;5974.40255974399;6002.879942401215;6016.518678505797;491621;495604;497548;499204;504098;66636;67098.66450667716;67318;67974.66012670004;68107.65946170238;480.24121887417795;490.9337239472697;492.0405209840825;493.7013107070243;493.72104760810026;9574.712758617252;9644.18024467928;9685.806283874424;9839.655612053544;9866.457344846101;32083;33039.66960330462;33473;33777;34664;44228.11543769171;44903.775481122386;45011.32483012692;45644.54355456536;45873.54126458693;5837.795677151279;5876.529877609866;5931.6441013539325;5932.347441781314;5936.821895343147;10463.21525885577;10609.89390106089;10779.622713205314;10791.838122428328;10816.188785840935;8349.123342048997;9025.368224224241;9582.808343832945;10011.199104071802;10050.447225402673;9702.854457183006;9737.123658870736;9779.902200977898;9877.753056173653;10203.28576999603;10173;10322;10363.844542332023;10582.894171058191;10618.73453163677;6287.622742635456;6375.171227740364;6500.414962653384;6508.674566271762;6510.251321098134;10441.425721585385;10583;10587.576496940344;10615.416152111708;10656.307340022873 19:07:02 INFO - 2015-11-14 19:07:02,075 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.8831293496507;1594.9122798246096;1655.4537002789082;1673.698734227839;1677.069226579248;6043.18417013703;6149.385061493848;6678;6987.825304367387;7000.684969176386;7058.717651293942;7155.6064416457075;7256.7822965311125;7261.709531618729;7280.199178090405;2037.8879161646103;2063.319104695447;2085.8122768950793;2087.7912208779153;2090.2370634718295;2101.579684063186;2110.198124712607;2122.8195603373733;2161.8378621603442;2164.5995490834166;2074.502119491319;2084.3642688979853;2096.4758810297426;2097.695834104054;2107.4099252209407;2100.5693832764323;2120.120150137691;2121.5544735605463;2125.224293133003;2130.669746189343;2077;2100.47488127968;2116.2381542644634;2120.056574824204;2130.5312831177116;7102.751403700846;7170.426365890717;7175.138983321983;7191.35277824993;7201.711931522733;4246.808893599796;4292.227399068166;4302.26861433557;4302.548232435581;4325.891852703708;2372.5966585680476;2422.769836865495;2890.161853062609;2946.3665311957816;2947.410517896429;1747.161362545985;1798.1638538079856;1807.3493542324752;1807.358387772335;1835.5686413692772;9291.76770580741;9381.765455863659;9428.198603118743;9434.05659434058;9481.431114133105;3951.269015232191;3969.563348031714;4028.536718277377;4033.092554175287;4035.556088830226;8560.571971401405;8596.484210947363;8614.26778723803;8616.526091064927;8620.568971551524;4319.049809042069;4348.9130217396105;4351.912961740811;4353.434053573015;4382.758948257876;3912.3349030664854;3950.170464202492;3952.644262016375;3961.643452089326;3969.6625786807867;3419.6238413774463;3422.0760394693293;3434.10713214566;3438.5014172944784;3458.775179613317;1096.819024860889;1100.9504572294265;1117.9944100279608;1121.0751130317522;1145.238416453066;1167.64970508847;1174.4773575758877;1188.8573371195512;1199.232491205629;1200.3098218524208;6782.830429239309;6821.965890170617;6845.520813543004;6846.520743548003;6900.551464154814;397.02530288142543;398.9341758609797;400.4513816071942;400.8216343727072;405.5012334828178;5365.141577347684;5371.221172929903;5424.023675738326;5425.511703946664;5428.837134885881;7818.8827167592535;8045.798855028671;8555.101714320032;8706.869396959051;8763.912360876437;8534.103919088531;8555.230029297392;8582.699605513902;8636.568171591396;8674.6530138795;6728.899066514006;6733.797986060426;6896.344847239404;6918.93081069193;6923.896141557881;6522.804315870531;6553.5084868635995;6571;6576.967115164585;6608.372204640552;7653.846923061396;7705.576193309422;7715.691372345268;7781.5331080135375;7800.726974555863;7828.412869034959;8068.515889046676;8098.595070246346;8105.311048560939;8134.837303253784;6400.807975760735;6477.77327793525;6498.122753428227;6541.738330466918;6544.44372228366;6782.559133656297;6815.556988795713;6861.2795656455355;6883.346082122191;6887.758928437481;6428.067930150196;6582.341765823379;6627.204735431586;6648.434883034803;6772.153480814898;6340.968295158495;6383.521235907233;6509.707063182073;6557.9344206559235;6590.011498275297;6554.213494380705;6600.867982640224;6665.900011499928;6668.233153187445;6671.532992690465;5798.59409841307;5992.8501787453915;6000.789972350947;6002.759889604367;6049.485793707584;6167.475764560063;6213.409726076015;6223.3465486123305;6232.844178895564;6234.563580549318 19:07:02 INFO - 2015-11-14 19:07:02,078 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.5959656480925;291.96350456192977;292.7043685877263;293.1703279718397;306.79444772002756;5686.630369026016;5738.626989245696;5752.539796816255;5824.825255242345;5951.404859514047;5730.19777231188;5781.595288329819;5802.419758024195;5809.2738407699035;5815.592908496407;4197.223513649985;4354.651627869779;4359.084592235635;4360.760158191299;4375.16871794358;4304.677149213806;4319.892002699926;4343.153085148398;4354.564543545652;4357.433533640622;4285.742855428684;4290.871273861789;4293.141371725652;4304.074623955848;4306.892327691817;4296.312589985588;4305.956940430587;4306.289462238727;4307.763073030982;4330.372096046056;3701.0192299040777;3705.3515634764076;3706.1475860551955;3706.499622550948;3707.9432361777035;5348.5186333230195;5405.081136206854;5518.779248830042;5534.75093620788;5561.749721262553;4927.088488629579;4930.087933732271;4934.062528119646;4938.9012219755405;4945.678530895516;6008.579399442041;6037.788677396314;6044.697765111727;6050.062240352709;6052.182955301022;3941.724079314449;3970.166265084336;4019.1760689058674;4019.31671615826;4033.1328764315813;6270.247570291549;6352.269489008777;6365.8408539786415;6373.649449280288;6383.32975037619;4043.474348334698;4046.9797651012145;4050.9392359114636;4051.2505186540584;4056.1887622475624;4093.2018256440306;4098.139390727921;4107.589241075869;4107.691923105779;4112.876613701594;4743.976280118577;4826.710397376169;4828.61371090312;4835.105505481497;4837.661363704507;6027.849303767353;6030.909536356959;6036.396360363929;6038.154658347835;6051.727672254759;1470.6249906274045;1505.4956589542626;1509.124707669549;1509.9320530576151;1510.5392855179057;950.7195377363694;976.7411635916487;980.1766516126488;1002.4887307473095;1003.3779056984571;5241.685498870003;5269.4730526947;5273.3935597406025;5278.129108697022;5279.076161671692;6220.7511699531515;6268.780592679234;6278.843028924313;6285.497160227263;6285.717142728588;5210.957808438327;5229.816956406584;5245.947540524546;5251.343582052244;5265.736713164327;3315.5689760331484;3370.25854312051;3393.830308484615;3408.233147541783;3418.077119177808;5772.307323121252;5897.085951677497;5907.291125064934;5909.881802363929;5912.201852749909;6422.42198202164;6506.707198176094;6517.250516190698;6532.477401807844;6563.540552161398;5916.822495325147;5960.76156953717;5962.910556341659;5963.254593175853;5970.044792833212;6187.257529096537;6276.686165691788;6340.9365906340345;6345.46063584582;6349.269833969152;6191.969040154951;6193.225846769154;6198.1012753149635;6201.2868520118955;6206.937930620636;5901.527877769854;5966.3735307793795;5967.76128954837;5970.194023806905;5975.043992961106;4105.794710264535;4143.4199212109725;4153.584641535822;4154.543000270029;4157;6166.537509686881;6245.219347581552;6317.052442133717;6327.240731112296;6340.175777149126;6051.788187413419;6081.8175454734655;6087.117367981707;6087.756489740361;6090.116933044772;6060.2424696912885;6068.848278792889;6088.330283668704;6092.939070609237;6094.20775299226;5716.342620598684;5877.94122058774;5931.051031834886;5947.137665038459;5951.137085122719;6125.989211780006;6128.662923539248;6129.111278864629;6132.724027418866;6133.785317513865;5947.851303717442;5960.612560183574;5963.612365196248;5969.52243820502;5974.22335096452 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: |5;yui.html;748.1994266135234;764.3655765714458;780.2743448592809;785.9292663660272;791.5765065689857;10735.463226838667;11039.83440248397;11050.778984420307;11080.168987325942;11112.444377781108;10332.431716255604;11147.498362573684;11236.775264494725;11248.662540123789;11313.208075434723;772.09279097061;783.7648705388389;787.6967367563471;787.79123532264;790.0124843945068;581.3430823169812;589.599072630611;590.790269454344;592.1591340296767;594.0673143165233;807.1807115777491;820.228984754332;820.8891799607036;821.2485575698258;822.8724547695117;808.6805711743829;814.2386868278179;815.0993152566388;815.9877601835977;817.5299202958323;604.3171216525342;605.648723740234;606.1180981671657;606.2664176346626;608.1789584061526;10836.945815270952;10947.890521094847;10947.945260273727;10958.890411095947;10989.780204395947;11480.770384592344;11770.352630605314;12016.69958251042;12027.759444811143;12136.393180340947;9249.398789078756;9422.387544809633;9546.61813527458;9568.665096721581;9812.46031468269;2831.1365033664724;2850.8717107730204;2885.134459662093;2891.7542008929267;2893.8119022263486;34316.970490885564;34366.14084647879;34457.65542344569;34542.30915381679;34977.825110874284;7061.187963384174;7189.820254493575;7318.597477138702;7340.15588207363;7508.324250817453;11017.724556885982;11073.612423565137;11095.1123910087;11113.555457781598;11133.387663678413;5690.601657883908;5753.984956448966;5883.294004719461;5935.792247271324;6016.09758536223;3595.19108200658;3640.599534051305;3645.0887278180453;3655.670989610948;3684.392075307544;2397.4485868250053;2418.8427752196053;2420.45539753554;2421.0073869713333;2423.7576242375976;408.86916186820525;415.36449232674056;416.165587996072;419.1491272716391;419.22443479563174;483.68802122630706;531.9095753721876;589.1251491535068;595.330253464852;619.3651507205151;7355.301246381585;7357.632118394059;7380.409567234608;7459.36595389398;7462.776116716507;503.32554377134085;518.0028445242892;579.7275280618103;590.5688847141524;596.7374355283662;3434.10713214566;3512.24486735348;3519.771214871025;3528.929421411609;3667.211549516867;49923.50076499261;51103.48896510987;51180.74409627928;51204.48795511997;51584.484155158716;46540;47120.7643961778;47460;47669.76165119152;48408.75795620999;41695.166096677895;42677.786611067364;43336.3499547507;43397.783011085376;43668.563314367086;7102.822429439306;7201.459890508338;7346.77959661211;7425.368843648351;7541.245875412635;32206.838965805022;32293;32609.18477037998;33029.66970330362;33147.17132071718;38201;38235.61764382432;38545.807270963465;40521.79739101286;40837.79581102194;7176.461765367722;7249.782506524602;7275.745348912763;7446.106467223968;7476.102867655916;10618.52216650268;10922.672319830417;10927.39899305514;11069.225154239126;11247.437628118398;10253;10311.329763565343;10315.381077135396;10458.163346932075;10458.424786636808;9602.423854568748;9959.452230127412;10055.145312648214;10060.647877324258;10193.898061019592;10458.63394781179;10605.575776968835;10610.52252648648;10616.203784716023;10616.628418005334;9225.169734723639;9236.769080773034;9564.856527152237;9682.177014953808;9706.174975127193;7846.960765196138;8307.875381869157;8541.615627296911;8670.91329086701;8892.199702026848 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,293 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556822066__endTimestamp 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4857.40 Median:5022.90 stddev:516.84 (10.3%) stddev-sans-first:489.51 19:07:02 INFO - 2015-11-14 19:07:02,080 DEBUG : BROWSER_OUTPUT: Values: 2684.3 2751.5 2781.2 2789.0 2793.4 4706.2 4794.2 4846.5 4867.1 4892.8 4823.2 4860.0 4885.2 4940.1 4953.1 4425.8 4466.4 4579.2 4586.3 4603.3 4358.3 4570.7 4580.1 4633.7 4684.2 4453.1 4486.9 4492.1 4530.8 4564.5 4534.1 4555.3 4566.1 4574.6 4580.9 4290.0 4549.2 4557.0 4567.7 4570.4 4658.5 4753.2 4762.2 4812.0 4842.3 5294.2 5294.2 5300.8 5310.4 5338.8 5106.1 5318.6 5320.1 5331.7 5338.4 4812.5 4889.8 4895.5 4915.9 4955.2 5406.7 5435.9 5458.2 5480.3 5530.3 5031.7 5173.5 5212.5 5221.8 5226.9 5167.7 5169.8 5200.9 5223.6 5264.1 5227.3 5227.7 5235.9 5236.8 5273.3 4908.7 5013.9 5060.7 5189.3 5202.0 4382.0 4390.3 4400.8 4404.2 4458.0 3845.5 3852.4 3859.3 3866.6 3892.0 4362.0 4471.8 4533.4 4588.9 4667.8 5353.9 5373.1 5374.2 5377.9 5395.5 4622.6 4629.6 4634.0 4650.3 4664.2 4522.0 4610.7 4642.5 4685.6 4716.2 5022.9 5025.4 5041.0 5059.1 5082.6 5104.8 5310.4 5323.5 5330.2 5330.4 4941.2 4947.2 5043.1 5068.5 5076.3 5236.8 5248.5 5261.6 5264.7 5286.6 5077.5 5215.5 5285.4 5311.5 5336.9 5024.8 5081.5 5088.0 5121.3 5151.7 5113.2 5134.8 5136.5 5143.8 5178.2 4746.1 4842.4 4928.2 5039.1 5048.1 5194.2 5203.1 5204.5 5205.6 5207.2 5070.7 5081.1 5081.4 5093.9 5134.2 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41484.14 Median:38249.40 stddev:67597.29 (176.7%) stddev-sans-first:67717.06 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: Values: 555.3 561.4 577.6 580.2 582.7 28101.3 37189.3 37604.8 37682.6 37813.6 40790.6 41154.0 41216.6 41290.8 41344.6 7862.0 7969.6 8016.8 8066.9 8079.7 7899.6 7912.4 7989.8 8022.3 8024.7 7808.4 8019.4 8048.3 8048.6 8058.6 7914.6 7962.6 7988.2 8018.1 8037.7 7878.6 7993.7 7996.4 8005.7 8051.1 37552.0 37886.0 38095.4 38202.2 38248.0 2918.1 2941.8 2950.1 3041.4 3066.0 28744.7 29076.0 29154.7 29625.3 30156.5 3094.7 3127.3 3139.3 3193.6 3200.3 219474.0 222364.0 222872.0 223452.0 223512.0 39504.0 40256.6 40269.2 58483.0 59372.7 42787.8 42802.6 42925.0 43013.6 43081.0 12598.6 12711.7 12739.9 12791.7 12813.6 9589.9 9641.9 9673.0 9763.6 9784.7 13941.0 14034.1 14062.2 14100.6 14161.1 5649.7 5846.7 5856.7 5883.7 5969.9 777.1 809.5 828.5 847.3 895.3 27174.6 27485.3 27853.2 27944.0 28338.9 876.1 918.2 951.1 981.3 986.0 14179.4 14188.4 14920.9 14980.4 15239.2 329848.0 332065.0 333988.0 334498.0 336363.0 48952.0 49863.0 49899.8 49901.8 50138.7 1176.5 1181.3 1188.4 1194.6 1198.2 28217.0 28501.0 28850.4 28988.4 29314.3 42383.8 43028.8 43145.8 43445.0 43529.0 197027.0 198457.0 199102.0 199243.0 199433.0 36235.6 43555.0 43688.6 44337.3 44407.8 40507.2 40607.6 40801.2 40804.1 41087.8 34955.0 35088.5 35290.5 38250.8 39601.0 35258.0 35313.0 39778.4 40007.8 40028.0 34138.1 34338.7 34351.0 34637.8 34895.8 30336.2 31293.7 31628.0 31713.5 32151.2 24302.5 24489.1 24574.9 24637.6 24840.3 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24618.12 Median:22677.19 stddev:81543.39 (359.6%) stddev-sans-first:81751.75 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: Values: 331.6 332.6 338.9 340.1 345.1 11300.5 11780.7 15126.5 15165.8 17193.4 10212.4 10249.4 10825.9 10887.0 11151.8 4201.9 4305.9 4308.8 4325.6 4331.1 4237.1 4313.3 4337.3 4346.1 4351.8 4287.7 4300.0 4489.5 4565.7 4586.4 4555.3 4611.9 4618.2 4621.5 4634.2 3938.5 4040.6 4044.3 4046.9 4048.8 11291.8 11374.8 11536.4 11634.6 11636.9 1686.5 1754.7 1760.3 1771.9 1869.6 9430.6 9526.6 9644.0 9783.0 9815.0 1687.9 1691.6 1804.3 1843.5 1871.1 52812.0 54022.5 54102.0 54401.7 54844.2 6356.4 6368.3 6389.3 6764.1 6774.7 7238.8 7254.7 7254.8 7258.7 7329.0 5024.0 5033.5 5057.4 5078.2 5105.0 5119.6 5193.3 5198.2 5198.7 5215.2 3090.4 3134.1 3144.1 3145.7 3160.2 1086.5 1092.1 1093.8 1109.7 1168.4 358.6 360.9 366.5 373.6 433.3 8059.1 8649.6 8745.3 8791.8 8935.3 380.2 381.6 386.8 450.6 461.4 5785.3 5892.1 5974.4 6002.9 6016.5 491621.0 495604.0 497548.0 499204.0 504098.0 66636.0 67098.7 67318.0 67974.7 68107.7 480.2 490.9 492.0 493.7 493.7 9574.7 9644.2 9685.8 9839.7 9866.5 32083.0 33039.7 33473.0 33777.0 34664.0 44228.1 44903.8 45011.3 45644.5 45873.5 5837.8 5876.5 5931.6 5932.3 5936.8 10463.2 10609.9 10779.6 10791.8 10816.2 8349.1 9025.4 9582.8 10011.2 10050.4 9702.9 9737.1 9779.9 9877.8 10203.3 10173.0 10322.0 10363.8 10582.9 10618.7 6287.6 6375.2 6500.4 6508.7 6510.3 10441.4 10583.0 10587.6 10615.4 10656.3 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,081 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5055.04 Median:6099.44 stddev:2566.47 (42.1%) stddev-sans-first:2559.45 19:07:02 INFO - 2015-11-14 19:07:02,082 DEBUG : BROWSER_OUTPUT: Values: 1460.9 1594.9 1655.5 1673.7 1677.1 6043.2 6149.4 6678.0 6987.8 7000.7 7058.7 7155.6 7256.8 7261.7 7280.2 2037.9 2063.3 2085.8 2087.8 2090.2 2101.6 2110.2 2122.8 2161.8 2164.6 2074.5 2084.4 2096.5 2097.7 2107.4 2100.6 2120.1 2121.6 2125.2 2130.7 2077.0 2100.5 2116.2 2120.1 2130.5 7102.8 7170.4 7175.1 7191.4 7201.7 4246.8 4292.2 4302.3 4302.5 4325.9 2372.6 2422.8 2890.2 2946.4 2947.4 1747.2 1798.2 1807.3 1807.4 1835.6 9291.8 9381.8 9428.2 9434.1 9481.4 3951.3 3969.6 4028.5 4033.1 4035.6 8560.6 8596.5 8614.3 8616.5 8620.6 4319.0 4348.9 4351.9 4353.4 4382.8 3912.3 3950.2 3952.6 3961.6 3969.7 3419.6 3422.1 3434.1 3438.5 3458.8 1096.8 1101.0 1118.0 1121.1 1145.2 1167.6 1174.5 1188.9 1199.2 1200.3 6782.8 6822.0 6845.5 6846.5 6900.6 397.0 398.9 400.5 400.8 405.5 5365.1 5371.2 5424.0 5425.5 5428.8 7818.9 8045.8 8555.1 8706.9 8763.9 8534.1 8555.2 8582.7 8636.6 8674.7 6728.9 6733.8 6896.3 6918.9 6923.9 6522.8 6553.5 6571.0 6577.0 6608.4 7653.8 7705.6 7715.7 7781.5 7800.7 7828.4 8068.5 8098.6 8105.3 8134.8 6400.8 6477.8 6498.1 6541.7 6544.4 6782.6 6815.6 6861.3 6883.3 6887.8 6428.1 6582.3 6627.2 6648.4 6772.2 6341.0 6383.5 6509.7 6557.9 6590.0 6554.2 6600.9 6665.9 6668.2 6671.5 5798.6 5992.9 6000.8 6002.8 6049.5 6167.5 6213.4 6223.3 6232.8 6234.6 19:07:02 INFO - 2015-11-14 19:07:02,082 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,082 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4962.45 Median:5745.58 stddev:1516.29 (26.4%) stddev-sans-first:1479.41 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: Values: 288.6 292.0 292.7 293.2 306.8 5686.6 5738.6 5752.5 5824.8 5951.4 5730.2 5781.6 5802.4 5809.3 5815.6 4197.2 4354.7 4359.1 4360.8 4375.2 4304.7 4319.9 4343.2 4354.6 4357.4 4285.7 4290.9 4293.1 4304.1 4306.9 4296.3 4306.0 4306.3 4307.8 4330.4 3701.0 3705.4 3706.1 3706.5 3707.9 5348.5 5405.1 5518.8 5534.8 5561.7 4927.1 4930.1 4934.1 4938.9 4945.7 6008.6 6037.8 6044.7 6050.1 6052.2 3941.7 3970.2 4019.2 4019.3 4033.1 6270.2 6352.3 6365.8 6373.6 6383.3 4043.5 4047.0 4050.9 4051.3 4056.2 4093.2 4098.1 4107.6 4107.7 4112.9 4744.0 4826.7 4828.6 4835.1 4837.7 6027.8 6030.9 6036.4 6038.2 6051.7 1470.6 1505.5 1509.1 1509.9 1510.5 950.7 976.7 980.2 1002.5 1003.4 5241.7 5269.5 5273.4 5278.1 5279.1 6220.8 6268.8 6278.8 6285.5 6285.7 5211.0 5229.8 5245.9 5251.3 5265.7 3315.6 3370.3 3393.8 3408.2 3418.1 5772.3 5897.1 5907.3 5909.9 5912.2 6422.4 6506.7 6517.3 6532.5 6563.5 5916.8 5960.8 5962.9 5963.3 5970.0 6187.3 6276.7 6340.9 6345.5 6349.3 6192.0 6193.2 6198.1 6201.3 6206.9 5901.5 5966.4 5967.8 5970.2 5975.0 4105.8 4143.4 4153.6 4154.5 4157.0 6166.5 6245.2 6317.1 6327.2 6340.2 6051.8 6081.8 6087.1 6087.8 6090.1 6060.2 6068.8 6088.3 6092.9 6094.2 5716.3 5877.9 5931.1 5947.1 5951.1 6126.0 6128.7 6129.1 6132.7 6133.8 5947.9 5960.6 5963.6 5969.5 5974.2 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11853.52 Median:47564.88 stddev:14037.06 (29.5%) stddev-sans-first:14051.67 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: Values: 748.2 764.4 780.3 785.9 791.6 10735.5 11039.8 11050.8 11080.2 11112.4 10332.4 11147.5 11236.8 11248.7 11313.2 772.1 783.8 787.7 787.8 790.0 581.3 589.6 590.8 592.2 594.1 807.2 820.2 820.9 821.2 822.9 808.7 814.2 815.1 816.0 817.5 604.3 605.6 606.1 606.3 608.2 10836.9 10947.9 10947.9 10958.9 10989.8 11480.8 11770.4 12016.7 12027.8 12136.4 9249.4 9422.4 9546.6 9568.7 9812.5 2831.1 2850.9 2885.1 2891.8 2893.8 34317.0 34366.1 34457.7 34542.3 34977.8 7061.2 7189.8 7318.6 7340.2 7508.3 11017.7 11073.6 11095.1 11113.6 11133.4 5690.6 5754.0 5883.3 5935.8 6016.1 3595.2 3640.6 3645.1 3655.7 3684.4 2397.4 2418.8 2420.5 2421.0 2423.8 408.9 415.4 416.2 419.1 419.2 483.7 531.9 589.1 595.3 619.4 7355.3 7357.6 7380.4 7459.4 7462.8 503.3 518.0 579.7 590.6 596.7 3434.1 3512.2 3519.8 3528.9 3667.2 49923.5 51103.5 51180.7 51204.5 51584.5 46540.0 47120.8 47460.0 47669.8 48408.8 41695.2 42677.8 43336.3 43397.8 43668.6 7102.8 7201.5 7346.8 7425.4 7541.2 32206.8 32293.0 32609.2 33029.7 33147.2 38201.0 38235.6 38545.8 40521.8 40837.8 7176.5 7249.8 7275.7 7446.1 7476.1 10618.5 10922.7 10927.4 11069.2 11247.4 10253.0 10311.3 10315.4 10458.2 10458.4 9602.4 9959.5 10055.1 10060.6 10193.9 10458.6 10605.6 10610.5 10616.2 10616.6 9225.2 9236.8 9564.9 9682.2 9706.2 7847.0 8307.9 8541.6 8670.9 8892.2 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:07:02 INFO - 2015-11-14 19:07:02,083 DEBUG : BROWSER_OUTPUT: 19:07:02 INFO - 2015-11-14 19:07:02,775 INFO : Browser exited with error code: 0 19:07:02 INFO - 2015-11-14 19:07:02,796 INFO : Completed test dromaeo_css (00:18:34) 19:07:02 INFO - 2015-11-14 19:07:02,796 INFO : Starting test kraken 19:07:02 INFO - 2015-11-14 19:07:02,796 DEBUG : operating with platform_type : linux_ 19:07:02 INFO - 2015-11-14 19:07:02,797 INFO : Initialising browser for kraken test... 19:07:02 INFO - 2015-11-14 19:07:02,803 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNyoVB/profile http://localhost:47938/getInfo.html 19:07:07 INFO - 2015-11-14 19:07:07,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:07:07 INFO - 2015-11-14 19:07:07,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:07:07 INFO - 2015-11-14 19:07:07,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:07:07 INFO - 2015-11-14 19:07:07,361 DEBUG : BROWSER_OUTPUT: __metrics 19:07:08 INFO - 2015-11-14 19:07:08,371 INFO : Browser initialized. 19:07:08 INFO - 2015-11-14 19:07:08,371 INFO : Running cycle 1/1 for kraken test... 19:07:08 INFO - 2015-11-14 19:07:08,371 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNyoVB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:07:20 INFO - 2015-11-14 19:07:20,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 19:07:20 INFO - 2015-11-14 19:07:20,364 DEBUG : BROWSER_OUTPUT: 19:07:22 INFO - 2015-11-14 19:07:22,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47938/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:23 INFO - 2015-11-14 19:07:23,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 141316096 19:07:23 INFO - 2015-11-14 19:07:23,595 DEBUG : BROWSER_OUTPUT: 19:07:26 INFO - 2015-11-14 19:07:26,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47938/tests/kraken/driver.html?testName=audio-dft) 19:07:26 INFO - 2015-11-14 19:07:26,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 19:07:26 INFO - 2015-11-14 19:07:26,946 DEBUG : BROWSER_OUTPUT: 19:07:29 INFO - 2015-11-14 19:07:29,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47938/tests/kraken/driver.html?testName=audio-fft) 19:07:30 INFO - 2015-11-14 19:07:30,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 137039872 19:07:30 INFO - 2015-11-14 19:07:30,461 DEBUG : BROWSER_OUTPUT: 19:07:32 INFO - 2015-11-14 19:07:32,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47938/tests/kraken/driver.html?testName=audio-oscillator) 19:07:33 INFO - 2015-11-14 19:07:33,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 137179136 19:07:33 INFO - 2015-11-14 19:07:33,124 DEBUG : BROWSER_OUTPUT: 19:07:35 INFO - 2015-11-14 19:07:35,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:35 INFO - 2015-11-14 19:07:35,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 138764288 19:07:35 INFO - 2015-11-14 19:07:35,923 DEBUG : BROWSER_OUTPUT: 19:07:38 INFO - 2015-11-14 19:07:38,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47938/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:39 INFO - 2015-11-14 19:07:39,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 138338304 19:07:39 INFO - 2015-11-14 19:07:39,568 DEBUG : BROWSER_OUTPUT: 19:07:43 INFO - 2015-11-14 19:07:43,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47938/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:43 INFO - 2015-11-14 19:07:43,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 136294400 19:07:43 INFO - 2015-11-14 19:07:43,635 DEBUG : BROWSER_OUTPUT: 19:07:46 INFO - 2015-11-14 19:07:46,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47938/tests/kraken/driver.html?testName=json-parse-financial) 19:07:47 INFO - 2015-11-14 19:07:47,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 136945664 19:07:47 INFO - 2015-11-14 19:07:47,180 DEBUG : BROWSER_OUTPUT: 19:07:48 INFO - 2015-11-14 19:07:48,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:49 INFO - 2015-11-14 19:07:49,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 138686464 19:07:49 INFO - 2015-11-14 19:07:49,503 DEBUG : BROWSER_OUTPUT: 19:07:51 INFO - 2015-11-14 19:07:51,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:52 INFO - 2015-11-14 19:07:52,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 138649600 19:07:52 INFO - 2015-11-14 19:07:52,031 DEBUG : BROWSER_OUTPUT: 19:07:54 INFO - 2015-11-14 19:07:54,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:54 INFO - 2015-11-14 19:07:54,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 19:07:54 INFO - 2015-11-14 19:07:54,787 DEBUG : BROWSER_OUTPUT: 19:07:57 INFO - 2015-11-14 19:07:57,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:57 INFO - 2015-11-14 19:07:57,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 139182080 19:07:57 INFO - 2015-11-14 19:07:57,956 DEBUG : BROWSER_OUTPUT: 19:08:00 INFO - 2015-11-14 19:08:00,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:01 INFO - 2015-11-14 19:08:01,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 138391552 19:08:01 INFO - 2015-11-14 19:08:01,207 DEBUG : BROWSER_OUTPUT: 19:08:02 INFO - 2015-11-14 19:08:02,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47938/tests/kraken/driver.html?testName=ai-astar) 19:08:03 INFO - 2015-11-14 19:08:03,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568 19:08:03 INFO - 2015-11-14 19:08:03,237 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,240 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;111;111;116;126;112;113;112;112 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;139;162;162;133;167;161;135;169;134 19:08:03 INFO - 2015-11-14 19:08:03,241 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;164;164;164;166;168;168;167;164 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;73;73;140;72;74;73;75 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;127;90;91;92;130;91;91;129 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;111;110;110;110;110;111 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;150;148;148;149;150;149;148;148;149 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;95;96;95;95;96;95 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;72;71;72;74;74;71;72 19:08:03 INFO - 2015-11-14 19:08:03,242 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;69;70;68;68;69;69;69;70 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;84;83;84;91;84;85;83;94;93 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;124;136;130;132;120;125;127;128;131 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;151;155;150;150;141;152;152;149;145 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;75;73;74;70;71;71;70;70 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,757 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556883239__endTimestamp 19:08:03 INFO - 2015-11-14 19:08:03,243 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,246 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:08:03 INFO - 2015-11-14 19:08:03,246 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.30 Median:112.00 stddev:4.88 (4.4%) stddev-sans-first:5.15 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 111.0 111.0 116.0 126.0 112.0 113.0 112.0 112.0 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.60 Median:161.50 stddev:14.68 (9.1%) stddev-sans-first:15.55 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: Values: 154.0 139.0 162.0 162.0 133.0 167.0 161.0 135.0 169.0 134.0 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:1.87 (1.1%) stddev-sans-first:1.81 19:08:03 INFO - 2015-11-14 19:08:03,247 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 164.0 164.0 164.0 166.0 168.0 168.0 167.0 164.0 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:73.00 stddev:21.21 (29.1%) stddev-sans-first:22.31 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 73.0 140.0 72.0 74.0 73.0 75.0 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:91.00 stddev:18.15 (19.9%) stddev-sans-first:18.86 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 127.0 90.0 91.0 92.0 130.0 91.0 91.0 129.0 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 111.0 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: Values: 148.0 150.0 148.0 148.0 149.0 150.0 149.0 148.0 148.0 149.0 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 19:08:03 INFO - 2015-11-14 19:08:03,248 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:1.10 (1.5%) stddev-sans-first:1.09 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 72.0 71.0 72.0 74.0 74.0 71.0 72.0 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 69.0 70.0 68.0 68.0 69.0 69.0 69.0 70.0 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:4.32 (5.0%) stddev-sans-first:4.52 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: Values: 89.0 84.0 83.0 84.0 91.0 84.0 85.0 83.0 94.0 93.0 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:4.79 (3.7%) stddev-sans-first:4.78 19:08:03 INFO - 2015-11-14 19:08:03,249 DEBUG : BROWSER_OUTPUT: Values: 123.0 124.0 136.0 130.0 132.0 120.0 125.0 127.0 128.0 131.0 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.50 stddev:4.00 (2.6%) stddev-sans-first:4.16 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: Values: 152.0 151.0 155.0 150.0 150.0 141.0 152.0 152.0 149.0 145.0 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 75.0 73.0 74.0 70.0 71.0 71.0 70.0 70.0 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:08:03 INFO - 2015-11-14 19:08:03,250 DEBUG : BROWSER_OUTPUT: 19:08:04 INFO - 2015-11-14 19:08:04,227 INFO : Browser exited with error code: 0 19:08:04 INFO - 2015-11-14 19:08:04,278 INFO : Completed test kraken (00:01:01) 19:08:04 INFO - 2015-11-14 19:08:04,278 INFO : Starting test v8_7 19:08:04 INFO - 2015-11-14 19:08:04,278 DEBUG : operating with platform_type : linux_ 19:08:04 INFO - 2015-11-14 19:08:04,278 INFO : Initialising browser for v8_7 test... 19:08:04 INFO - 2015-11-14 19:08:04,284 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz311uV/profile http://localhost:47938/getInfo.html 19:08:08 INFO - 2015-11-14 19:08:08,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:08:08 INFO - 2015-11-14 19:08:08,668 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:08:08 INFO - 2015-11-14 19:08:08,668 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:08:08 INFO - 2015-11-14 19:08:08,668 DEBUG : BROWSER_OUTPUT: __metrics 19:08:09 INFO - 2015-11-14 19:08:09,755 INFO : Browser initialized. 19:08:09 INFO - 2015-11-14 19:08:09,755 INFO : Running cycle 1/1 for v8_7 test... 19:08:09 INFO - 2015-11-14 19:08:09,755 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz311uV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:08:21 INFO - 2015-11-14 19:08:21,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 19:08:21 INFO - 2015-11-14 19:08:21,715 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47938/tests/v8_7/run.html (next: http://localhost:47938/tests/v8_7/run.html) 19:08:43 INFO - 2015-11-14 19:08:43,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 138108928 19:08:43 INFO - 2015-11-14 19:08:43,468 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:08:43 INFO - 2015-11-14 19:08:43,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3453119895459 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.62142584826535 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5107.142857142857 19:08:43 INFO - 2015-11-14 19:08:43,469 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1052.6315789473683 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: |5;Earley;768.8172043010753 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: |6;Boyer;11916.666666666666 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: |7;RegExp;25769.23076923077 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: |8;Splay;596.793349168646 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:08:43 INFO - 2015-11-14 19:08:43,470 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556923466__endTimestamp 19:08:43 INFO - 2015-11-14 19:08:43,471 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:08:43 INFO - 2015-11-14 19:08:43,471 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:08:43 INFO - 2015-11-14 19:08:43,471 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,472 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.35 Median:163.35 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: Values: 163.3 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.62 Median:190.62 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: Values: 190.6 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,473 DEBUG : BROWSER_OUTPUT: Values: 279.8 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5107.14 Median:5107.14 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: Values: 5107.1 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: Values: 1052.6 19:08:43 INFO - 2015-11-14 19:08:43,474 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:768.82 Median:768.82 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: Values: 768.8 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: Values: 11916.7 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,475 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: Values: 25769.2 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.79 Median:596.79 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: Values: 596.8 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: 19:08:43 INFO - 2015-11-14 19:08:43,476 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 19:08:43 INFO - 2015-11-14 19:08:43,477 DEBUG : BROWSER_OUTPUT: Values: 4826.9 19:08:43 INFO - 2015-11-14 19:08:43,477 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:08:43 INFO - 2015-11-14 19:08:43,477 DEBUG : BROWSER_OUTPUT: 19:08:44 INFO - 2015-11-14 19:08:44,443 INFO : Browser exited with error code: 0 19:08:44 INFO - 2015-11-14 19:08:44,461 INFO : Completed test v8_7 (00:00:40) 19:08:44 INFO - 2015-11-14 19:08:44,950 INFO : Completed test suite (00:20:16) 19:08:44 INFO - 2015-11-14 19:08:44,950 DEBUG : Working with test: dromaeo_css 19:08:44 INFO - 2015-11-14 19:08:44,950 DEBUG : Generating results file: dromaeo_css 19:08:44 INFO - 2015-11-14 19:08:44,952 DEBUG : Working with test: kraken 19:08:44 INFO - 2015-11-14 19:08:44,952 DEBUG : Generating results file: kraken 19:08:44 INFO - 2015-11-14 19:08:44,952 INFO : javascript benchmark 19:08:44 INFO - 2015-11-14 19:08:44,952 DEBUG : Working with test: v8_7 19:08:44 INFO - 2015-11-14 19:08:44,952 DEBUG : Generating results file: v8_7 19:08:44 INFO - 2015-11-14 19:08:44,953 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:45 INFO - 2015-11-14 19:08:45,010 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 19:08:45 INFO - 2015-11-14 19:08:45,010 DEBUG : process_Request line: dromaeo_css 6083.19 graph.html#tests=[[72,131,43]] 19:08:45 INFO - 2015-11-14 19:08:45,011 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:45 INFO - 2015-11-14 19:08:45,043 DEBUG : process_Request line: kraken 1544.00 graph.html#tests=[[232,131,43]] 19:08:45 INFO - 2015-11-14 19:08:45,043 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:45 INFO - 2015-11-14 19:08:45,092 DEBUG : process_Request line: v8_7 21336.94 graph.html#tests=[[230,131,43]] 19:08:45 INFO - 2015-11-14 19:08:45,093 INFO : javascript benchmark 19:08:45 INFO - 2015-11-14 19:08:45,097 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [331.64348325550026, 332.6191510720225, 338.9406853800586, 340.09365042162636, 345.1010118640942, 11300.491477883494, 11780.705482362924, 15126.546203613896, 15165.848341516596, 17193.398231061914, 10212.438315892623, 10249.43628100456, 10825.945870270658, 10887.0, 11151.776964460705, 4201.936970945439, 4305.880471077511, 4308.849190278341, 4325.632321252698, 4331.112122014995, 4237.110206856564, 4313.331433627777, 4337.327714204288, 4346.087321662455, 4351.782410879443, 4287.678424118204, 4300.0, 4489.483709373415, 4565.748883811389, 4586.4266966629175, 4555.293929440909, 4611.861644150664, 4618.1687296286655, 4621.537846215385, 4634.189016922042, 3938.547067087293, 4040.5959404059654, 4044.2518134144984, 4046.8583599574167, 4048.7570745755347, 11291.774164516746, 11374.772504549863, 11536.423178841109, 11634.59278925242, 11636.883631163664, 1686.5109118355663, 1754.7280171573427, 1760.313477743681, 1771.8582513399026, 1869.5793446474433, 9430.622775088988, 9526.618935242583, 9643.951780241054, 9782.9510852446, 9815.0, 1687.8902871313326, 1691.5686499942435, 1804.3414153833755, 1843.4930394141584, 1871.0738184598574, 52812.0, 54022.45977540214, 54102.0, 54401.72799136019, 54844.17733733997, 6356.410897275681, 6368.267649220306, 6389.3291204423795, 6764.120664313607, 6774.695138718769, 7238.819029524304, 7254.673539690727, 7254.782356529313, 7258.745943891939, 7329.0, 5024.0, 5033.471485494044, 5057.393112826484, 5078.21287700407, 5105.0, 5119.564836988823, 5193.2989046479, 5198.16829307309, 5198.6880787152895, 5215.191645294985, 3090.4128215639407, 3134.1381120191672, 3144.0567829651013, 3145.685431456836, 3160.1625569224175, 1086.4676308608725, 1092.071739021841, 1093.8195197792434, 1109.6504601050804, 1168.4041139019162, 358.6341931230183, 360.9404448266059, 366.53633154060134, 373.5610657477507, 433.3240145373228, 8059.113497515269, 8649.56752162402, 8745.256653184424, 8791.824163516694, 8935.28517718581, 380.216753487816, 381.55548785664945, 386.8278616015902, 450.6012179221347, 461.3656222693796, 5785.334686511021, 5892.086726557391, 5974.40255974399, 6002.879942401215, 6016.518678505797, 491621.0, 495604.0, 497548.0, 499204.0, 504098.0, 66636.0, 67098.66450667716, 67318.0, 67974.66012670004, 68107.65946170238, 480.24121887417795, 490.9337239472697, 492.0405209840825, 493.7013107070243, 493.72104760810026, 9574.712758617252, 9644.18024467928, 9685.806283874424, 9839.655612053544, 9866.457344846101, 32083.0, 33039.66960330462, 33473.0, 33777.0, 34664.0, 44228.11543769171, 44903.775481122386, 45011.32483012692, 45644.54355456536, 45873.54126458693, 5837.795677151279, 5876.529877609866, 5931.6441013539325, 5932.347441781314, 5936.821895343147, 10463.21525885577, 10609.89390106089, 10779.622713205314, 10791.838122428328, 10816.188785840935, 8349.123342048997, 9025.368224224241, 9582.808343832945, 10011.199104071802, 10050.447225402673, 9702.854457183006, 9737.123658870736, 9779.902200977898, 9877.753056173653, 10203.28576999603, 10173.0, 10322.0, 10363.844542332023, 10582.894171058191, 10618.73453163677, 6287.622742635456, 6375.171227740364, 6500.414962653384, 6508.674566271762, 6510.251321098134, 10441.425721585385, 10583.0, 10587.576496940344, 10615.416152111708, 10656.307340022873], "dojo.html": [2684.342336127649, 2751.5184842652557, 2781.151748716642, 2788.9860550697244, 2793.4273473937833, 4706.22347312693, 4794.161021821181, 4846.539578740023, 4867.123917694814, 4892.779824907879, 4823.180059389903, 4859.951400485994, 4885.1695211813985, 4940.086084074449, 4953.083679519292, 4425.8450954216605, 4466.374707540939, 4579.198640237945, 4586.334981427691, 4603.332516785064, 4358.259095953696, 4570.702904311226, 4580.129775342691, 4633.652476064309, 4684.156851766681, 4453.087117141011, 4486.910261794778, 4492.0791237796175, 4530.77346132692, 4564.4522657281, 4534.070515544306, 4555.339475776027, 4566.06395688883, 4574.61115805157, 4580.885477863047, 4289.978550107261, 4549.226631472658, 4557.0430209656015, 4567.748773817439, 4570.382998295254, 4658.487566367697, 4753.215719406294, 4762.1666208413735, 4811.951880481185, 4842.2736589511505, 5294.205869119624, 5294.205869119624, 5300.787968481256, 5310.44240354761, 5338.759755810997, 5106.106431374495, 5318.601104917147, 5320.068987927136, 5331.680099194061, 5338.359396872362, 4812.494688057774, 4889.779959901813, 4895.510448955147, 4915.87710307238, 4955.1823949048, 5406.702631355234, 5435.945640543623, 5458.235846981426, 5480.314960629921, 5530.2810634618045, 5031.698098114125, 5173.456787037382, 5212.478752124833, 5221.843344699589, 5226.92159617606, 5167.741612919339, 5169.81905633301, 5200.933808569234, 5223.555997740159, 5264.05247055526, 5227.294315267391, 5227.712475813791, 5235.900460903177, 5236.842894713165, 5273.34083239595, 4908.656394052454, 5013.949860501349, 5060.746962651852, 5189.299444574934, 5201.973990130101, 4382.0, 4390.297552391602, 4400.801963911632, 4404.163208990281, 4458.019235768126, 3845.5000849889893, 3852.4221366794645, 3859.3439115350457, 3866.574676785551, 3891.9610803892165, 4361.996740749645, 4471.7987690554, 4533.365328853963, 4588.862334129982, 4667.813287468532, 5353.892922141613, 5373.086575282133, 5374.167004114369, 5377.919331210035, 5395.487428694268, 4622.583967442946, 4629.606483448944, 4633.9536604634195, 4650.348951146842, 4664.183767840615, 4521.977390113028, 4610.746408947473, 4642.4661163966575, 4685.625149988061, 4716.151092803259, 5022.89954200914, 5025.39695236574, 5041.0, 5059.114654935445, 5082.593392528515, 5104.795808167632, 5310.442403547727, 5323.520883120537, 5330.200469929541, 5330.387005494418, 4941.160002799461, 4947.208446648519, 5043.117454445531, 5068.518490743373, 5076.289319495199, 5236.764345604381, 5248.501392367872, 5261.579073674174, 5264.710440925785, 5286.550643195372, 5077.492250774893, 5215.530602245816, 5285.445028271976, 5311.521963023347, 5336.919946200887, 5024.84925452237, 5081.517255860687, 5088.033273677989, 5121.283020377075, 5151.6908985461, 5113.184277530224, 5134.76893539799, 5136.5377116059735, 5143.8456846294675, 5178.197379406198, 4746.145693775154, 4842.443119041355, 4928.162212423825, 5039.067772462106, 5048.1165795984825, 5194.194899790538, 5203.063448579292, 5204.453532379046, 5205.609579281493, 5207.192885102815, 5070.6957582545165, 5081.136206844919, 5081.441041485507, 5093.923591146062, 5134.229865520202], "mootools.html": [1460.8831293496507, 1594.9122798246096, 1655.4537002789082, 1673.698734227839, 1677.069226579248, 6043.18417013703, 6149.385061493848, 6678.0, 6987.825304367387, 7000.684969176386, 7058.717651293942, 7155.6064416457075, 7256.7822965311125, 7261.709531618729, 7280.199178090405, 2037.8879161646103, 2063.319104695447, 2085.8122768950793, 2087.7912208779153, 2090.2370634718295, 2101.579684063186, 2110.198124712607, 2122.8195603373733, 2161.8378621603442, 2164.5995490834166, 2074.502119491319, 2084.3642688979853, 2096.4758810297426, 2097.695834104054, 2107.4099252209407, 2100.5693832764323, 2120.120150137691, 2121.5544735605463, 2125.224293133003, 2130.669746189343, 2077.0, 2100.47488127968, 2116.2381542644634, 2120.056574824204, 2130.5312831177116, 7102.751403700846, 7170.426365890717, 7175.138983321983, 7191.35277824993, 7201.711931522733, 4246.808893599796, 4292.227399068166, 4302.26861433557, 4302.548232435581, 4325.891852703708, 2372.5966585680476, 2422.769836865495, 2890.161853062609, 2946.3665311957816, 2947.410517896429, 1747.161362545985, 1798.1638538079856, 1807.3493542324752, 1807.358387772335, 1835.5686413692772, 9291.76770580741, 9381.765455863659, 9428.198603118743, 9434.05659434058, 9481.431114133105, 3951.269015232191, 3969.563348031714, 4028.536718277377, 4033.092554175287, 4035.556088830226, 8560.571971401405, 8596.484210947363, 8614.26778723803, 8616.526091064927, 8620.568971551524, 4319.049809042069, 4348.9130217396105, 4351.912961740811, 4353.434053573015, 4382.758948257876, 3912.3349030664854, 3950.170464202492, 3952.644262016375, 3961.643452089326, 3969.6625786807867, 3419.6238413774463, 3422.0760394693293, 3434.10713214566, 3438.5014172944784, 3458.775179613317, 1096.819024860889, 1100.9504572294265, 1117.9944100279608, 1121.0751130317522, 1145.238416453066, 1167.64970508847, 1174.4773575758877, 1188.8573371195512, 1199.232491205629, 1200.3098218524208, 6782.830429239309, 6821.965890170617, 6845.520813543004, 6846.520743548003, 6900.551464154814, 397.02530288142543, 398.9341758609797, 400.4513816071942, 400.8216343727072, 405.5012334828178, 5365.141577347684, 5371.221172929903, 5424.023675738326, 5425.511703946664, 5428.837134885881, 7818.8827167592535, 8045.798855028671, 8555.101714320032, 8706.869396959051, 8763.912360876437, 8534.103919088531, 8555.230029297392, 8582.699605513902, 8636.568171591396, 8674.6530138795, 6728.899066514006, 6733.797986060426, 6896.344847239404, 6918.93081069193, 6923.896141557881, 6522.804315870531, 6553.5084868635995, 6571.0, 6576.967115164585, 6608.372204640552, 7653.846923061396, 7705.576193309422, 7715.691372345268, 7781.5331080135375, 7800.726974555863, 7828.412869034959, 8068.515889046676, 8098.595070246346, 8105.311048560939, 8134.837303253784, 6400.807975760735, 6477.77327793525, 6498.122753428227, 6541.738330466918, 6544.44372228366, 6782.559133656297, 6815.556988795713, 6861.2795656455355, 6883.346082122191, 6887.758928437481, 6428.067930150196, 6582.341765823379, 6627.204735431586, 6648.434883034803, 6772.153480814898, 6340.968295158495, 6383.521235907233, 6509.707063182073, 6557.9344206559235, 6590.011498275297, 6554.213494380705, 6600.867982640224, 6665.900011499928, 6668.233153187445, 6671.532992690465, 5798.59409841307, 5992.8501787453915, 6000.789972350947, 6002.759889604367, 6049.485793707584, 6167.475764560063, 6213.409726076015, 6223.3465486123305, 6232.844178895564, 6234.563580549318], "ext.html": [555.3252797850611, 561.3516388571201, 577.6332029161484, 580.1906340654787, 582.7057336045298, 28101.29746756332, 37189.25621487572, 37604.81197594008, 37682.623173768254, 37813.62186378135, 40790.59209407905, 41154.0, 41216.58783412165, 41290.793546032226, 41344.58655413445, 7861.960690196541, 7969.561674107922, 8016.799580010517, 8066.878996815052, 8079.676812927476, 7899.6050197490185, 7912.367010639164, 7989.760307190764, 8022.318102961255, 8024.67901283948, 7808.414368922326, 8019.398545109111, 8048.275655191032, 8048.557329346883, 8058.5567793771315, 7914.643841027168, 7962.562059086719, 7988.201179882023, 8018.0779210390965, 8037.678492860278, 7878.645460954271, 7993.720219792338, 7996.400269979775, 8005.719799806979, 8051.0741264754715, 37552.0, 37886.0, 38095.42856857149, 38202.23595528074, 38248.0, 2918.0953904289527, 2941.8381988990595, 2950.085473503221, 3041.422129795332, 3065.9693403065908, 28744.71255287441, 29076.0, 29154.708452915413, 29625.259368515744, 30156.54765178524, 3094.706002929718, 3127.3432579158402, 3139.3407384449292, 3193.6486986431473, 3200.2639392939755, 219474.0, 222364.0, 222872.0, 223452.0, 223511.99999999837, 39504.0, 40256.59743402587, 40269.19461610751, 58483.0, 59372.7031364849, 42787.7860610695, 42802.57197428048, 42925.0, 43013.56986430095, 43081.0, 12598.622041338775, 12711.745765084646, 12739.936300318439, 12791.680207994688, 12813.615591532269, 9589.904100958902, 9641.903580964101, 9672.984336644691, 9763.560639771227, 9784.706458806248, 13941.0, 14034.087784293988, 14062.15627062359, 14100.576982690536, 14161.079529830527, 5649.71751412436, 5846.6784326862435, 5856.707164641751, 5883.676397798076, 5969.910451343233, 777.1102088109084, 809.461707964209, 828.5235989306173, 847.326375531454, 895.3016647015338, 27174.5923811143, 27485.31286717808, 27853.16440506788, 27944.0, 28338.858305708338, 876.0669886570909, 918.2424499787702, 951.0917074194128, 981.2640519610293, 985.9654912078042, 14179.432822687184, 14188.432462701583, 14920.925395373171, 14980.40078396852, 15239.23803809805, 329848.0, 332065.0, 333988.0, 334498.0, 336363.0, 48952.0, 49863.0, 49899.75050124726, 49901.750491248036, 50138.74930625324, 1176.4647085576041, 1181.3384504677408, 1188.3998580716682, 1194.6296648039308, 1198.1852340408432, 28217.0, 28501.0, 28850.422991540472, 28988.42023159567, 29314.267143320736, 42383.7880810594, 43028.78485607552, 43145.784271078446, 43445.0, 43529.0, 197027.0, 198457.0, 199102.0, 199243.0, 199433.0, 36235.637643623224, 43555.0, 43688.56311436972, 44337.334939975284, 44407.77796111128, 40507.18985620212, 40607.593924060384, 40801.1839763209, 40804.144498457885, 41087.794561027, 34955.0, 35088.47367289442, 35290.47064294089, 38250.808745957205, 39601.0, 35258.0, 35313.0, 39778.403323949584, 40007.79996100001, 40028.0, 34138.14654633654, 34338.656613433544, 34351.0, 34637.82681086579, 34895.82552087223, 30336.241593960327, 31293.687063129077, 31628.0, 31713.524297136024, 32151.19622009375, 24302.51394972126, 24489.142879999115, 24574.877125614257, 24637.630435543124, 24840.25479235626], "prototype.html": [288.5959656480925, 291.96350456192977, 292.7043685877263, 293.1703279718397, 306.79444772002756, 5686.630369026016, 5738.626989245696, 5752.539796816255, 5824.825255242345, 5951.404859514047, 5730.19777231188, 5781.595288329819, 5802.419758024195, 5809.2738407699035, 5815.592908496407, 4197.223513649985, 4354.651627869779, 4359.084592235635, 4360.760158191299, 4375.16871794358, 4304.677149213806, 4319.892002699926, 4343.153085148398, 4354.564543545652, 4357.433533640622, 4285.742855428684, 4290.871273861789, 4293.141371725652, 4304.074623955848, 4306.892327691817, 4296.312589985588, 4305.956940430587, 4306.289462238727, 4307.763073030982, 4330.372096046056, 3701.0192299040777, 3705.3515634764076, 3706.1475860551955, 3706.499622550948, 3707.9432361777035, 5348.5186333230195, 5405.081136206854, 5518.779248830042, 5534.75093620788, 5561.749721262553, 4927.088488629579, 4930.087933732271, 4934.062528119646, 4938.9012219755405, 4945.678530895516, 6008.579399442041, 6037.788677396314, 6044.697765111727, 6050.062240352709, 6052.182955301022, 3941.724079314449, 3970.166265084336, 4019.1760689058674, 4019.31671615826, 4033.1328764315813, 6270.247570291549, 6352.269489008777, 6365.8408539786415, 6373.649449280288, 6383.32975037619, 4043.474348334698, 4046.9797651012145, 4050.9392359114636, 4051.2505186540584, 4056.1887622475624, 4093.2018256440306, 4098.139390727921, 4107.589241075869, 4107.691923105779, 4112.876613701594, 4743.976280118577, 4826.710397376169, 4828.61371090312, 4835.105505481497, 4837.661363704507, 6027.849303767353, 6030.909536356959, 6036.396360363929, 6038.154658347835, 6051.727672254759, 1470.6249906274045, 1505.4956589542626, 1509.124707669549, 1509.9320530576151, 1510.5392855179057, 950.7195377363694, 976.7411635916487, 980.1766516126488, 1002.4887307473095, 1003.3779056984571, 5241.685498870003, 5269.4730526947, 5273.3935597406025, 5278.129108697022, 5279.076161671692, 6220.7511699531515, 6268.780592679234, 6278.843028924313, 6285.497160227263, 6285.717142728588, 5210.957808438327, 5229.816956406584, 5245.947540524546, 5251.343582052244, 5265.736713164327, 3315.5689760331484, 3370.25854312051, 3393.830308484615, 3408.233147541783, 3418.077119177808, 5772.307323121252, 5897.085951677497, 5907.291125064934, 5909.881802363929, 5912.201852749909, 6422.42198202164, 6506.707198176094, 6517.250516190698, 6532.477401807844, 6563.540552161398, 5916.822495325147, 5960.76156953717, 5962.910556341659, 5963.254593175853, 5970.044792833212, 6187.257529096537, 6276.686165691788, 6340.9365906340345, 6345.46063584582, 6349.269833969152, 6191.969040154951, 6193.225846769154, 6198.1012753149635, 6201.2868520118955, 6206.937930620636, 5901.527877769854, 5966.3735307793795, 5967.76128954837, 5970.194023806905, 5975.043992961106, 4105.794710264535, 4143.4199212109725, 4153.584641535822, 4154.543000270029, 4157.0, 6166.537509686881, 6245.219347581552, 6317.052442133717, 6327.240731112296, 6340.175777149126, 6051.788187413419, 6081.8175454734655, 6087.117367981707, 6087.756489740361, 6090.116933044772, 6060.2424696912885, 6068.848278792889, 6088.330283668704, 6092.939070609237, 6094.20775299226, 5716.342620598684, 5877.94122058774, 5931.051031834886, 5947.137665038459, 5951.137085122719, 6125.989211780006, 6128.662923539248, 6129.111278864629, 6132.724027418866, 6133.785317513865, 5947.851303717442, 5960.612560183574, 5963.612365196248, 5969.52243820502, 5974.22335096452], "yui.html": [748.1994266135234, 764.3655765714458, 780.2743448592809, 785.9292663660272, 791.5765065689857, 10735.463226838667, 11039.83440248397, 11050.778984420307, 11080.168987325942, 11112.444377781108, 10332.431716255604, 11147.498362573684, 11236.775264494725, 11248.662540123789, 11313.208075434723, 772.09279097061, 783.7648705388389, 787.6967367563471, 787.79123532264, 790.0124843945068, 581.3430823169812, 589.599072630611, 590.790269454344, 592.1591340296767, 594.0673143165233, 807.1807115777491, 820.228984754332, 820.8891799607036, 821.2485575698258, 822.8724547695117, 808.6805711743829, 814.2386868278179, 815.0993152566388, 815.9877601835977, 817.5299202958323, 604.3171216525342, 605.648723740234, 606.1180981671657, 606.2664176346626, 608.1789584061526, 10836.945815270952, 10947.890521094847, 10947.945260273727, 10958.890411095947, 10989.780204395947, 11480.770384592344, 11770.352630605314, 12016.69958251042, 12027.759444811143, 12136.393180340947, 9249.398789078756, 9422.387544809633, 9546.61813527458, 9568.665096721581, 9812.46031468269, 2831.1365033664724, 2850.8717107730204, 2885.134459662093, 2891.7542008929267, 2893.8119022263486, 34316.970490885564, 34366.14084647879, 34457.65542344569, 34542.30915381679, 34977.825110874284, 7061.187963384174, 7189.820254493575, 7318.597477138702, 7340.15588207363, 7508.324250817453, 11017.724556885982, 11073.612423565137, 11095.1123910087, 11113.555457781598, 11133.387663678413, 5690.601657883908, 5753.984956448966, 5883.294004719461, 5935.792247271324, 6016.09758536223, 3595.19108200658, 3640.599534051305, 3645.0887278180453, 3655.670989610948, 3684.392075307544, 2397.4485868250053, 2418.8427752196053, 2420.45539753554, 2421.0073869713333, 2423.7576242375976, 408.86916186820525, 415.36449232674056, 416.165587996072, 419.1491272716391, 419.22443479563174, 483.68802122630706, 531.9095753721876, 589.1251491535068, 595.330253464852, 619.3651507205151, 7355.301246381585, 7357.632118394059, 7380.409567234608, 7459.36595389398, 7462.776116716507, 503.32554377134085, 518.0028445242892, 579.7275280618103, 590.5688847141524, 596.7374355283662, 3434.10713214566, 3512.24486735348, 3519.771214871025, 3528.929421411609, 3667.211549516867, 49923.50076499261, 51103.48896510987, 51180.74409627928, 51204.48795511997, 51584.484155158716, 46540.0, 47120.7643961778, 47460.0, 47669.76165119152, 48408.75795620999, 41695.166096677895, 42677.786611067364, 43336.3499547507, 43397.783011085376, 43668.563314367086, 7102.822429439306, 7201.459890508338, 7346.77959661211, 7425.368843648351, 7541.245875412635, 32206.838965805022, 32293.0, 32609.18477037998, 33029.66970330362, 33147.17132071718, 38201.0, 38235.61764382432, 38545.807270963465, 40521.79739101286, 40837.79581102194, 7176.461765367722, 7249.782506524602, 7275.745348912763, 7446.106467223968, 7476.102867655916, 10618.52216650268, 10922.672319830417, 10927.39899305514, 11069.225154239126, 11247.437628118398, 10253.0, 10311.329763565343, 10315.381077135396, 10458.163346932075, 10458.424786636808, 9602.423854568748, 9959.452230127412, 10055.145312648214, 10060.647877324258, 10193.898061019592, 10458.63394781179, 10605.575776968835, 10610.52252648648, 10616.203784716023, 10616.628418005334, 9225.169734723639, 9236.769080773034, 9564.856527152237, 9682.177014953808, 9706.174975127193, 7846.960765196138, 8307.875381869157, 8541.615627296911, 8670.91329086701, 8892.199702026848]}, "summary": {"lowerIsBetter": false, "suite": 6083.192489321798, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6273.210834628225, "unit": "ms", "value": 6273.210834628225}, "dojo.html": {"lowerIsBetter": false, "filtered": 4824.4068368419785, "unit": "ms", "value": 4824.4068368419785}, "mootools.html": {"lowerIsBetter": false, "filtered": 4143.596235619333, "unit": "ms", "value": 4143.596235619333}, "ext.html": {"lowerIsBetter": false, "filtered": 16809.616238471153, "unit": "ms", "value": 16809.616238471153}, "prototype.html": {"lowerIsBetter": false, "filtered": 4461.957291851358, "unit": "ms", "value": 4461.957291851358}, "yui.html": {"lowerIsBetter": false, "filtered": 5387.104836333175, "unit": "ms", "value": 5387.104836333175}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-035.e"}, "testrun": {"date": 1447555708, "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": "20151114182033", "branch": "Mozilla-Inbound-Non-PGO", "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 164.0, 164.0, 164.0, 164.0, 166.0, 168.0, 168.0, 167.0, 164.0], "ai-astar": [112.0, 108.0, 111.0, 111.0, 116.0, 126.0, 112.0, 113.0, 112.0, 112.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0], "audio-beat-detection": [154.0, 139.0, 162.0, 162.0, 133.0, 167.0, 161.0, 135.0, 169.0, 134.0], "json-stringify-tinderbox": [68.0, 70.0, 69.0, 70.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [152.0, 151.0, 155.0, 150.0, 150.0, 141.0, 152.0, 152.0, 149.0, 145.0], "json-parse-financial": [71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 74.0, 74.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [71.0, 71.0, 75.0, 73.0, 74.0, 70.0, 71.0, 71.0, 70.0, 70.0], "audio-fft": [72.0, 72.0, 73.0, 73.0, 73.0, 140.0, 72.0, 74.0, 73.0, 75.0], "imaging-darkroom": [148.0, 150.0, 148.0, 148.0, 149.0, 150.0, 149.0, 148.0, 148.0, 149.0], "stanford-crypto-ccm": [123.0, 124.0, 136.0, 130.0, 132.0, 120.0, 125.0, 127.0, 128.0, 131.0], "audio-oscillator": [92.0, 91.0, 127.0, 90.0, 91.0, 92.0, 130.0, 91.0, 91.0, 129.0], "stanford-crypto-aes": [89.0, 84.0, 83.0, 84.0, 91.0, 84.0, 85.0, 83.0, 94.0, 93.0], "imaging-desaturate": [96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1543.9999999999995, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.7, "unit": "ms", "value": 79.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.7, "unit": "ms", "value": 149.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.6, "unit": "ms", "value": 151.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 127.6, "unit": "ms", "value": 127.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.7, "unit": "ms", "value": 148.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.1, "unit": "ms", "value": 72.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.4, "unit": "ms", "value": 102.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.3, "unit": "ms", "value": 113.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 165.2, "unit": "ms", "value": 165.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.6, "unit": "ms", "value": 71.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.0, "unit": "ms", "value": 69.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.3, "unit": "ms", "value": 110.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.0, "unit": "ms", "value": 87.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-035.e"}, "testrun": {"date": 1447555708, "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": "20151114182033", "branch": "Mozilla-Inbound-Non-PGO", "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.62142584826535], "Encrypt": [279.79854504756577], "NavierStokes": [4826.923076923077], "Decrypt": [5107.142857142857], "Splay": [596.793349168646], "Richards": [163.3453119895459], "RegExp": [25769.23076923077], "Earley": [768.8172043010753], "Boyer": [11916.666666666666], "RayTrace": [1052.6315789473683]}, "summary": {"lowerIsBetter": false, "suite": 21336.93559482997, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 346.8550280000001, "unit": "score", "value": 346.8550280000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 951.330894, "unit": "score", "value": 951.330894}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.119356643356625, "unit": "score", "value": 52.119356643356625}, "Splay": {"lowerIsBetter": false, "filtered": 136.548103482587, "unit": "score", "value": 136.548103482587}, "RegExp": {"lowerIsBetter": false, "filtered": 35.3516567164179, "unit": "score", "value": 35.3516567164179}, "Richards": {"lowerIsBetter": false, "filtered": 216.118844, "unit": "score", "value": 216.118844}, "Earley": {"lowerIsBetter": false, "filtered": 866.8679580419582, "unit": "score", "value": 866.8679580419582}, "Boyer": {"lowerIsBetter": false, "filtered": 55.926965034964994, "unit": "score", "value": 55.926965034964994}, "RayTrace": {"lowerIsBetter": false, "filtered": 702.9895499999999, "unit": "score", "value": 702.9895499999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-035.e"}, "testrun": {"date": 1447555708, "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": "20151114182033", "branch": "Mozilla-Inbound-Non-PGO", "revision": "0af3033225956bfc2ba52c0087dc5c9ea0ccf297"}}] 19:08:45 INFO - RETURN: dromaeo_css: 6083.19 19:08:45 INFO - RETURN: kraken: 1544.00 19:08:45 INFO - RETURN: v8_7: 21336.94 19:08:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21336.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1544.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6083.19"}}} 19:08:45 INFO - Return code: 0 19:08:45 INFO - # TBPL SUCCESS # 19:08:45 INFO - Running post-action listener: _resource_record_post_action 19:08:45 INFO - Running post-run listener: _resource_record_post_run 19:08:46 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507371520; Read time: 192; Write time: 481968 19:08:46 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 149135360; Read time: 0; Write time: 123360 19:08:46 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 289546240; Read time: 0; Write time: 231300 19:08:46 INFO - Running post-run listener: _upload_blobber_files 19:08:46 INFO - Blob upload gear active. 19:08:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:08:46 INFO - Copying logs to upload dir... 19:08:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.699481 ========= master_lag: 19.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-11-14 19:09:04.657550) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 19:09:04.661514) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010077 build_url: 'https://queue.taskcluster.net/v1/task/d056YPDPSROGwlKXGcyHbQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.21 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 19:09:04.886119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 19:09:04.886497) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1447553337.107619-1426961468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 19:09:05.115118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 19:09:05.115491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 19:09:05.119553) ========= ========= Total master_lag: 20.11 =========