builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1447285309.29 results: success (0) buildid: 20151111143931 builduid: 71dfd44a22eb43929456b6ee85e31b61 revision: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.287945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.288350) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.288627) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006575 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.342346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.342619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.374490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.374750) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.425339) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.425603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.425943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.426233) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-11 15:41:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-11-11 15:41:49 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.627964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.628290) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.678555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:49.678859) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 --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 c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 --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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-11 15:41:50,056 truncating revision to first 12 chars 2015-11-11 15:41:50,057 Setting DEBUG logging. 2015-11-11 15:41:50,057 attempt 1/10 2015-11-11 15:41:50,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c5780f2a10e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 15:41:50,345 unpacking tar archive at: mozilla-inbound-c5780f2a10e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:50.278486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:50.278760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:50.286850) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:50.287130) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 15:41:50.287498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-11 15:41:50.287834) ========= /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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:50 INFO - MultiFileLogger online at 20151111 15:41:50 in /builds/slave/test 15:41:50 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 15:41:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:50 INFO - {'append_to_log': False, 15:41:50 INFO - 'base_work_dir': '/builds/slave/test', 15:41:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 15:41:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:50 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 15:41:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:50 INFO - 'config_files': ('talos/linux_config.py',), 15:41:50 INFO - 'default_actions': ('clobber', 15:41:50 INFO - 'read-buildbot-config', 15:41:50 INFO - 'download-and-extract', 15:41:50 INFO - 'populate-webroot', 15:41:50 INFO - 'create-virtualenv', 15:41:50 INFO - 'install', 15:41:50 INFO - 'run-tests'), 15:41:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:50 INFO - 'download_minidump_stackwalk': True, 15:41:50 INFO - 'download_symbols': 'ondemand', 15:41:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:50 INFO - 'installer_path': 'installer.exe', 15:41:50 INFO - 'log_level': 'info', 15:41:50 INFO - 'log_name': 'talos', 15:41:50 INFO - 'log_to_console': True, 15:41:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:50 INFO - 'opt_config_files': (), 15:41:50 INFO - 'pip_index': False, 15:41:50 INFO - 'sps_profile': False, 15:41:50 INFO - 'sps_profile_interval': 0, 15:41:50 INFO - 'suite': 'dromaeojs-e10s', 15:41:50 INFO - 'system_bits': '64', 15:41:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:50 INFO - 'title': 'talos-linux64-ix-046', 15:41:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:50 INFO - 'use_talos_json': True, 15:41:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:50 INFO - 'work_dir': 'build'} 15:41:50 INFO - ##### 15:41:50 INFO - ##### Running clobber step. 15:41:50 INFO - ##### 15:41:50 INFO - Running pre-action listener: _resource_record_pre_action 15:41:50 INFO - Running main action method: clobber 15:41:50 INFO - rmtree: /builds/slave/test/build 15:41:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:51 INFO - Running post-action listener: _resource_record_post_action 15:41:51 INFO - ##### 15:41:51 INFO - ##### Running read-buildbot-config step. 15:41:51 INFO - ##### 15:41:51 INFO - Running pre-action listener: _resource_record_pre_action 15:41:51 INFO - Running main action method: read_buildbot_config 15:41:51 INFO - Using buildbot properties: 15:41:51 INFO - { 15:41:51 INFO - "properties": { 15:41:51 INFO - "buildnumber": 1042, 15:41:51 INFO - "product": "firefox", 15:41:51 INFO - "script_repo_revision": "production", 15:41:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:41:51 INFO - "repository": "", 15:41:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 15:41:51 INFO - "buildid": "20151111143931", 15:41:51 INFO - "slavename": "talos-linux64-ix-046", 15:41:51 INFO - "pgo_build": "False", 15:41:51 INFO - "basedir": "/builds/slave/test", 15:41:51 INFO - "project": "", 15:41:51 INFO - "platform": "ubuntu64_hw", 15:41:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:41:51 INFO - "slavebuilddir": "test", 15:41:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 15:41:51 INFO - "branch": "mozilla-inbound", 15:41:51 INFO - "repo_path": "integration/mozilla-inbound", 15:41:51 INFO - "stage_platform": "linux64", 15:41:51 INFO - "builduid": "71dfd44a22eb43929456b6ee85e31b61", 15:41:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 15:41:51 INFO - }, 15:41:51 INFO - "sourcestamp": { 15:41:51 INFO - "repository": "", 15:41:51 INFO - "hasPatch": false, 15:41:51 INFO - "project": "", 15:41:51 INFO - "branch": "mozilla-inbound-linux64-talos", 15:41:51 INFO - "changes": [ 15:41:51 INFO - { 15:41:51 INFO - "category": null, 15:41:51 INFO - "files": [ 15:41:51 INFO - { 15:41:51 INFO - "url": null, 15:41:51 INFO - "name": "https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:41:51 INFO - } 15:41:51 INFO - ], 15:41:51 INFO - "repository": "", 15:41:51 INFO - "rev": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5", 15:41:51 INFO - "who": "tnikkel@gmail.com", 15:41:51 INFO - "when": 1447285227, 15:41:51 INFO - "number": 6650940, 15:41:51 INFO - "comments": "Bug 1223639. Rename ForceInside to MoveInsideAndClamp so it's clearer what it does. r=botond\n\nThis has led to confusion at least twice.", 15:41:51 INFO - "project": "", 15:41:51 INFO - "at": "Wed 11 Nov 2015 15:40:27", 15:41:51 INFO - "branch": "mozilla-inbound-linux64-talos", 15:41:51 INFO - "revlink": "", 15:41:51 INFO - "properties": [ 15:41:51 INFO - [ 15:41:51 INFO - "buildid", 15:41:51 INFO - "20151111143931", 15:41:51 INFO - "Change" 15:41:51 INFO - ], 15:41:51 INFO - [ 15:41:51 INFO - "builduid", 15:41:51 INFO - "71dfd44a22eb43929456b6ee85e31b61", 15:41:51 INFO - "Change" 15:41:51 INFO - ], 15:41:51 INFO - [ 15:41:51 INFO - "pgo_build", 15:41:51 INFO - "False", 15:41:51 INFO - "Change" 15:41:51 INFO - ] 15:41:51 INFO - ], 15:41:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 15:41:51 INFO - } 15:41:51 INFO - ], 15:41:51 INFO - "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5" 15:41:51 INFO - } 15:41:51 INFO - } 15:41:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:41:51 INFO - Running post-action listener: _resource_record_post_action 15:41:51 INFO - ##### 15:41:51 INFO - ##### Running download-and-extract step. 15:41:51 INFO - ##### 15:41:51 INFO - Running pre-action listener: _resource_record_pre_action 15:41:51 INFO - Running main action method: download_and_extract 15:41:51 INFO - mkdir: /builds/slave/test/build/tests 15:41:51 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')]} 15:41:51 INFO - https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:41:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/test_packages.json 15:41:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/test_packages.json 15:41:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:41:56 INFO - Downloaded 1302 bytes. 15:41:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:41:56 INFO - Using the following test package requirements: 15:41:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:41:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'jsshell-linux-x86_64.zip'], 15:41:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:41:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:41:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:41:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:41:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:41:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:41:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:41:56 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')]} 15:41:56 INFO - https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:41:58 INFO - Downloaded 21250985 bytes. 15:41:58 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 15:41:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:58 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 15:41:59 INFO - Return code: 0 15:41:59 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 15:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:41:59 INFO - https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:42:02 INFO - Downloaded 21250985 bytes. 15:42:02 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 15:42:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:42:02 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 15:42:03 INFO - Return code: 0 15:42: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')]} 15:42:03 INFO - https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:42:04 INFO - Downloaded 11131693 bytes. 15:42:04 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 15:42:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:42:04 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 15:42:04 INFO - Return code: 0 15:42:04 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')]} 15:42:04 INFO - https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:42:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-r_VYqP8SruAH9XFKFGKlQ/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 15:42:08 INFO - Downloaded 55637303 bytes. 15:42:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:08 INFO - mkdir: /builds/slave/test/properties 15:42:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:08 INFO - Contents: 15:42:08 INFO - build_url:https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:42:08 INFO - Running post-action listener: _resource_record_post_action 15:42:08 INFO - Running post-action listener: set_extra_try_arguments 15:42:08 INFO - ##### 15:42:08 INFO - ##### Running populate-webroot step. 15:42:08 INFO - ##### 15:42:08 INFO - Running pre-action listener: _resource_record_pre_action 15:42:08 INFO - Running main action method: populate_webroot 15:42:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:42:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:42:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:42:08 INFO - '../fennec_ids.txt'], 15:42:08 INFO - 'tests': ['tcheck2']}, 15:42:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:42:08 INFO - '--tppagecycles', 15:42:08 INFO - '7'], 15:42:08 INFO - 'tests': ['tsvgm']}}, 15:42:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:42:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:42:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:42:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'tests': ['damp', 'tps']}, 15:42:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['damp', 'tps']}, 15:42:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:42:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:08 INFO - 'other': {'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'other_l64': {'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'other_nol64': {'tests': ['a11yr', 15:42:08 INFO - 'ts_paint', 15:42:08 INFO - 'tpaint', 15:42:08 INFO - 'sessionrestore', 15:42:08 INFO - 'sessionrestore_no_auto_restore']}, 15:42:08 INFO - 'svgr': {'tests': ['tsvgx', 15:42:08 INFO - 'tsvgr_opacity', 15:42:08 INFO - 'tart', 15:42:08 INFO - 'tscrollx', 15:42:08 INFO - 'cart']}, 15:42:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['tsvgx', 15:42:08 INFO - 'tsvgr_opacity', 15:42:08 INFO - 'tart', 15:42:08 INFO - 'tscrollx', 15:42:08 INFO - 'cart']}, 15:42:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'tests': ['tp5o']}, 15:42:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'talos_options': ['--e10s'], 15:42:08 INFO - 'tests': ['tp5o']}, 15:42:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'talos_options': ['--xperf_path', 15:42:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:08 INFO - 'tests': ['tp5n']}, 15:42:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:42:08 INFO - 'talos_options': ['--e10s', 15:42:08 INFO - '--xperf_path', 15:42:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:08 INFO - 'tests': ['tp5n']}}, 15:42:08 INFO - 'talos.zip': {'path': '', 15:42:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:42:08 INFO - Running post-action listener: _resource_record_post_action 15:42:08 INFO - ##### 15:42:08 INFO - ##### Running create-virtualenv step. 15:42:08 INFO - ##### 15:42:08 INFO - Running pre-action listener: _resource_record_pre_action 15:42:08 INFO - Running main action method: create_virtualenv 15:42:08 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:08 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 15:42:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:42:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:08 INFO - Using real prefix '/usr' 15:42:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:09 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:11 INFO - Installing pip.................done. 15:42:11 INFO - Return code: 0 15:42:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42:11 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')]} 15:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:11 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')]} 15:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:11 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:11 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 15:42:11 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 15:42:11 INFO - Using env: {'DISPLAY': ':0', 15:42:11 INFO - 'HOME': '/home/cltbld', 15:42:11 INFO - 'LANG': 'en_US.UTF-8', 15:42:11 INFO - 'LANGUAGE': 'en_US:en', 15:42:11 INFO - 'LOGNAME': 'cltbld', 15:42:11 INFO - 'MAIL': '/var/mail/cltbld', 15:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:11 INFO - 'MOZ_NO_REMOTE': '1', 15:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:11 INFO - 'NO_EM_RESTART': '1', 15:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:11 INFO - 'PWD': '/builds/slave/test', 15:42:11 INFO - 'SHELL': '/bin/bash', 15:42:11 INFO - 'SHLVL': '1', 15:42:11 INFO - 'TERM': 'linux', 15:42:11 INFO - 'TMOUT': '86400', 15:42:11 INFO - 'USER': 'cltbld', 15:42:11 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:11 INFO - '_': '/tools/buildbot/bin/python'} 15:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:11 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 15:42:11 INFO - Cleaning up... 15:42:11 INFO - Return code: 0 15:42:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:42:11 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')]} 15:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:11 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')]} 15:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:11 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:11 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 15:42:11 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 15:42:11 INFO - Using env: {'DISPLAY': ':0', 15:42:11 INFO - 'HOME': '/home/cltbld', 15:42:11 INFO - 'LANG': 'en_US.UTF-8', 15:42:11 INFO - 'LANGUAGE': 'en_US:en', 15:42:11 INFO - 'LOGNAME': 'cltbld', 15:42:11 INFO - 'MAIL': '/var/mail/cltbld', 15:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:11 INFO - 'MOZ_NO_REMOTE': '1', 15:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:11 INFO - 'NO_EM_RESTART': '1', 15:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:11 INFO - 'PWD': '/builds/slave/test', 15:42:11 INFO - 'SHELL': '/bin/bash', 15:42:11 INFO - 'SHLVL': '1', 15:42:11 INFO - 'TERM': 'linux', 15:42:11 INFO - 'TMOUT': '86400', 15:42:11 INFO - 'USER': 'cltbld', 15:42:11 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:11 INFO - '_': '/tools/buildbot/bin/python'} 15:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:11 INFO - Downloading/unpacking psutil>=0.7.1 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:42:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:13 INFO - Installing collected packages: psutil 15:42:13 INFO - Running setup.py install for psutil 15:42:13 INFO - building 'psutil._psutil_linux' extension 15:42:13 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 15:42:13 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 15:42:13 INFO - building 'psutil._psutil_posix' extension 15:42:13 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 15:42:13 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 15:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:14 INFO - Successfully installed psutil 15:42:14 INFO - Cleaning up... 15:42:14 INFO - Return code: 0 15:42:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:42:14 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')]} 15:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:14 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')]} 15:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:14 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:14 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 15:42:14 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 15:42:14 INFO - Using env: {'DISPLAY': ':0', 15:42:14 INFO - 'HOME': '/home/cltbld', 15:42:14 INFO - 'LANG': 'en_US.UTF-8', 15:42:14 INFO - 'LANGUAGE': 'en_US:en', 15:42:14 INFO - 'LOGNAME': 'cltbld', 15:42:14 INFO - 'MAIL': '/var/mail/cltbld', 15:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:14 INFO - 'MOZ_NO_REMOTE': '1', 15:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:14 INFO - 'NO_EM_RESTART': '1', 15:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:14 INFO - 'PWD': '/builds/slave/test', 15:42:14 INFO - 'SHELL': '/bin/bash', 15:42:14 INFO - 'SHLVL': '1', 15:42:14 INFO - 'TERM': 'linux', 15:42:14 INFO - 'TMOUT': '86400', 15:42:14 INFO - 'USER': 'cltbld', 15:42:14 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:14 INFO - '_': '/tools/buildbot/bin/python'} 15:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:42:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:42:16 INFO - Installing collected packages: mozsystemmonitor 15:42:16 INFO - Running setup.py install for mozsystemmonitor 15:42:16 INFO - Successfully installed mozsystemmonitor 15:42:16 INFO - Cleaning up... 15:42:16 INFO - Return code: 0 15:42:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42:16 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')]} 15:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:16 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')]} 15:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:16 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:16 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 15:42:16 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 15:42:16 INFO - Using env: {'DISPLAY': ':0', 15:42:16 INFO - 'HOME': '/home/cltbld', 15:42:16 INFO - 'LANG': 'en_US.UTF-8', 15:42:16 INFO - 'LANGUAGE': 'en_US:en', 15:42:16 INFO - 'LOGNAME': 'cltbld', 15:42:16 INFO - 'MAIL': '/var/mail/cltbld', 15:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:16 INFO - 'MOZ_NO_REMOTE': '1', 15:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:16 INFO - 'NO_EM_RESTART': '1', 15:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:16 INFO - 'PWD': '/builds/slave/test', 15:42:16 INFO - 'SHELL': '/bin/bash', 15:42:16 INFO - 'SHLVL': '1', 15:42:16 INFO - 'TERM': 'linux', 15:42:16 INFO - 'TMOUT': '86400', 15:42:16 INFO - 'USER': 'cltbld', 15:42:16 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:16 INFO - '_': '/tools/buildbot/bin/python'} 15:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:16 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:16 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 15:42:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 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 15:42:18 INFO - Downloading docopt-0.6.1.tar.gz 15:42:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:18 INFO - Running setup.py install for blobuploader 15:42:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:18 INFO - Running setup.py install for requests 15:42:19 INFO - Running setup.py install for docopt 15:42:19 INFO - Successfully installed blobuploader requests docopt 15:42:19 INFO - Cleaning up... 15:42:19 INFO - Return code: 0 15:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:19 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:19 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 15:42:19 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 15:42:19 INFO - Using env: {'DISPLAY': ':0', 15:42:19 INFO - 'HOME': '/home/cltbld', 15:42:19 INFO - 'LANG': 'en_US.UTF-8', 15:42:19 INFO - 'LANGUAGE': 'en_US:en', 15:42:19 INFO - 'LOGNAME': 'cltbld', 15:42:19 INFO - 'MAIL': '/var/mail/cltbld', 15:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:19 INFO - 'MOZ_NO_REMOTE': '1', 15:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:19 INFO - 'NO_EM_RESTART': '1', 15:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:19 INFO - 'PWD': '/builds/slave/test', 15:42:19 INFO - 'SHELL': '/bin/bash', 15:42:19 INFO - 'SHLVL': '1', 15:42:19 INFO - 'TERM': 'linux', 15:42:19 INFO - 'TMOUT': '86400', 15:42:19 INFO - 'USER': 'cltbld', 15:42:19 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:19 INFO - '_': '/tools/buildbot/bin/python'} 15:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:19 INFO - Running setup.py (path:/tmp/pip-f850Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:19 INFO - Running setup.py (path:/tmp/pip-c9D2Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:19 INFO - Running setup.py (path:/tmp/pip-lrMn_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:19 INFO - Running setup.py (path:/tmp/pip-aS6y0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:19 INFO - Running setup.py (path:/tmp/pip-JmJmQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:19 INFO - Running setup.py (path:/tmp/pip-VY7i0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:20 INFO - Running setup.py (path:/tmp/pip-vQvOEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:20 INFO - Running setup.py (path:/tmp/pip-sKaAob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:20 INFO - Running setup.py (path:/tmp/pip-4dpolj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:20 INFO - Running setup.py (path:/tmp/pip-Ernsnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:20 INFO - Running setup.py (path:/tmp/pip-Nvyh6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:20 INFO - Running setup.py (path:/tmp/pip-xKjB8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:20 INFO - Running setup.py (path:/tmp/pip-1Z6NLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:20 INFO - Running setup.py (path:/tmp/pip-we76bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:20 INFO - Running setup.py (path:/tmp/pip-ynjwGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:20 INFO - Running setup.py (path:/tmp/pip-FxR_f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:20 INFO - Running setup.py (path:/tmp/pip-cOczBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:20 INFO - Running setup.py install for manifestparser 15:42:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:20 INFO - Running setup.py install for mozcrash 15:42:21 INFO - Running setup.py install for mozdebug 15:42:21 INFO - Running setup.py install for mozdevice 15:42:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozfile 15:42:21 INFO - Running setup.py install for mozhttpd 15:42:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozinfo 15:42:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozInstall 15:42:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozleak 15:42:21 INFO - Running setup.py install for mozlog 15:42:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for moznetwork 15:42:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:21 INFO - Running setup.py install for mozprocess 15:42:22 INFO - Running setup.py install for mozprofile 15:42:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for mozrunner 15:42:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Running setup.py install for mozscreenshot 15:42:22 INFO - Running setup.py install for moztest 15:42:22 INFO - Running setup.py install for mozversion 15:42:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:42:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:22 INFO - Cleaning up... 15:42:22 INFO - Return code: 0 15:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:22 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:22 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 15:42:22 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 15:42:22 INFO - Using env: {'DISPLAY': ':0', 15:42:22 INFO - 'HOME': '/home/cltbld', 15:42:22 INFO - 'LANG': 'en_US.UTF-8', 15:42:22 INFO - 'LANGUAGE': 'en_US:en', 15:42:22 INFO - 'LOGNAME': 'cltbld', 15:42:22 INFO - 'MAIL': '/var/mail/cltbld', 15:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:22 INFO - 'MOZ_NO_REMOTE': '1', 15:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:22 INFO - 'NO_EM_RESTART': '1', 15:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:22 INFO - 'PWD': '/builds/slave/test', 15:42:22 INFO - 'SHELL': '/bin/bash', 15:42:22 INFO - 'SHLVL': '1', 15:42:22 INFO - 'TERM': 'linux', 15:42:22 INFO - 'TMOUT': '86400', 15:42:22 INFO - 'USER': 'cltbld', 15:42:22 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:22 INFO - '_': '/tools/buildbot/bin/python'} 15:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:22 INFO - Running setup.py (path:/tmp/pip-vCaJ1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:22 INFO - Running setup.py (path:/tmp/pip-HZpsrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:22 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)) 15:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:22 INFO - Running setup.py (path:/tmp/pip-4uol6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:23 INFO - Running setup.py (path:/tmp/pip-8_fK2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:23 INFO - Running setup.py (path:/tmp/pip-16rOvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:23 INFO - Running setup.py (path:/tmp/pip-Y_OgJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:23 INFO - Running setup.py (path:/tmp/pip-y4ENev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:23 INFO - Running setup.py (path:/tmp/pip-Aqfp2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:23 INFO - Running setup.py (path:/tmp/pip-vTq6Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:23 INFO - Running setup.py (path:/tmp/pip-OL5tDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:23 INFO - Running setup.py (path:/tmp/pip-OLvUe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:23 INFO - Running setup.py (path:/tmp/pip-t2wbFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:23 INFO - Running setup.py (path:/tmp/pip-rNZbVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:23 INFO - Running setup.py (path:/tmp/pip-OC1LBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:23 INFO - Running setup.py (path:/tmp/pip-xB1O3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:23 INFO - Running setup.py (path:/tmp/pip-FZvzJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:23 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)) 15:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:23 INFO - Running setup.py (path:/tmp/pip-VNgZgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 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)) 15:42:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:42:24 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 15:42:24 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 15:42:24 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 15:42:24 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 15:42:24 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 15:42:24 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 15:42:25 INFO - Downloading blessings-1.5.1.tar.gz 15:42:25 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 15:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:42:25 INFO - Installing collected packages: blessings 15:42:25 INFO - Running setup.py install for blessings 15:42:25 INFO - Successfully installed blessings 15:42:25 INFO - Cleaning up... 15:42:25 INFO - Return code: 0 15:42:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:25 INFO - Reading from file tmpfile_stdout 15:42:25 INFO - Current package versions: 15:42:25 INFO - argparse == 1.2.1 15:42:25 INFO - blessings == 1.5.1 15:42:25 INFO - blobuploader == 1.2.4 15:42:25 INFO - docopt == 0.6.1 15:42:25 INFO - manifestparser == 1.1 15:42:25 INFO - mozInstall == 1.12 15:42:25 INFO - mozcrash == 0.16 15:42:25 INFO - mozdebug == 0.1 15:42:25 INFO - mozdevice == 0.47 15:42:25 INFO - mozfile == 1.2 15:42:25 INFO - mozhttpd == 0.7 15:42:25 INFO - mozinfo == 0.9 15:42:25 INFO - mozleak == 0.1 15:42:25 INFO - mozlog == 3.0 15:42:25 INFO - moznetwork == 0.27 15:42:25 INFO - mozprocess == 0.22 15:42:25 INFO - mozprofile == 0.27 15:42:25 INFO - mozrunner == 6.11 15:42:25 INFO - mozscreenshot == 0.1 15:42:25 INFO - mozsystemmonitor == 0.0 15:42:25 INFO - moztest == 0.7 15:42:25 INFO - mozversion == 1.4 15:42:25 INFO - psutil == 3.1.1 15:42:25 INFO - requests == 1.2.3 15:42:25 INFO - wsgiref == 0.1.2 15:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:25 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 0x7f0fb1404c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18529a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, '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': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', '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 15:42:25 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 15:42:25 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 15:42:25 INFO - Using env: {'DISPLAY': ':0', 15:42:25 INFO - 'HOME': '/home/cltbld', 15:42:25 INFO - 'LANG': 'en_US.UTF-8', 15:42:25 INFO - 'LANGUAGE': 'en_US:en', 15:42:25 INFO - 'LOGNAME': 'cltbld', 15:42:25 INFO - 'MAIL': '/var/mail/cltbld', 15:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:25 INFO - 'MOZ_NO_REMOTE': '1', 15:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:25 INFO - 'NO_EM_RESTART': '1', 15:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:25 INFO - 'PWD': '/builds/slave/test', 15:42:25 INFO - 'SHELL': '/bin/bash', 15:42:25 INFO - 'SHLVL': '1', 15:42:25 INFO - 'TERM': 'linux', 15:42:25 INFO - 'TMOUT': '86400', 15:42:25 INFO - 'USER': 'cltbld', 15:42:25 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:25 INFO - '_': '/tools/buildbot/bin/python'} 15:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 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)) 15:42:25 INFO - Cleaning up... 15:42:25 INFO - Return code: 0 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - Running post-action listener: _start_resource_monitoring 15:42:25 INFO - Starting resource monitoring. 15:42:25 INFO - ##### 15:42:25 INFO - ##### Running install step. 15:42:25 INFO - ##### 15:42:25 INFO - Running pre-action listener: _resource_record_pre_action 15:42:25 INFO - Running main action method: install 15:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:26 INFO - Reading from file tmpfile_stdout 15:42:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:42:26 INFO - Reading from file tmpfile_stdout 15:42:26 INFO - Output received: 15:42:26 INFO - Usage: mozinstall [options] installer 15:42:26 INFO - Options: 15:42:26 INFO - -h, --help show this help message and exit 15:42:26 INFO - -d DEST, --destination=DEST 15:42:26 INFO - Directory to install application into. [default: 15:42:26 INFO - "/builds/slave/test"] 15:42:26 INFO - --app=APP Application being installed. [default: firefox] 15:42:26 INFO - mkdir: /builds/slave/test/build/application 15:42:26 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'] 15:42:26 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 15:42:40 INFO - Reading from file tmpfile_stdout 15:42:40 INFO - Output received: 15:42:40 INFO - /builds/slave/test/build/application/firefox/firefox 15:42:40 INFO - Running post-action listener: _resource_record_post_action 15:42:40 INFO - ##### 15:42:40 INFO - ##### Running run-tests step. 15:42:40 INFO - ##### 15:42:40 INFO - Running pre-action listener: _resource_record_pre_action 15:42:40 INFO - Running main action method: run_tests 15:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:42:40 INFO - Python 2.7.3 15:42:40 INFO - Return code: 0 15:42:40 INFO - grabbing minidump binary from tooltool 15:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:40 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 0x18e1ac0>, '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 0x18e29a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e2e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:42:40 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 15:42:40 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 15:42:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:40 INFO - Return code: 0 15:42:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:42:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:42:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:42:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:42:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:42:40 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/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test/build 15:42:40 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/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 15:42:40 INFO - Using env: {'DISPLAY': ':0', 15:42:40 INFO - 'HOME': '/home/cltbld', 15:42:40 INFO - 'LANG': 'en_US.UTF-8', 15:42:40 INFO - 'LANGUAGE': 'en_US:en', 15:42:40 INFO - 'LOGNAME': 'cltbld', 15:42:40 INFO - 'MAIL': '/var/mail/cltbld', 15:42:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:42:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:40 INFO - 'MOZ_NO_REMOTE': '1', 15:42:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:40 INFO - 'NO_EM_RESTART': '1', 15:42:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:40 INFO - 'PWD': '/builds/slave/test', 15:42:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:42:40 INFO - 'SHELL': '/bin/bash', 15:42:40 INFO - 'SHLVL': '1', 15:42:40 INFO - 'TERM': 'linux', 15:42:40 INFO - 'TMOUT': '86400', 15:42:40 INFO - 'USER': 'cltbld', 15:42:40 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283', 15:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:40 INFO - '_': '/tools/buildbot/bin/python'} 15:42:40 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/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 15:42:40 INFO - mozversion INFO | application_buildid: 20151111143931 15:42:40 INFO - mozversion INFO | application_changeset: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 15:42:40 INFO - mozversion INFO | application_display_name: Nightly 15:42:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:40 INFO - mozversion INFO | application_name: Firefox 15:42:40 INFO - mozversion INFO | application_remotingname: firefox 15:42:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:42:40 INFO - mozversion INFO | application_vendor: Mozilla 15:42:40 INFO - mozversion INFO | application_version: 45.0a1 15:42:40 INFO - mozversion INFO | platform_buildid: 20151111143931 15:42:40 INFO - mozversion INFO | platform_changeset: c5780f2a10e8de3171e12f080d99f62a0c6ca1a5 15:42:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:42:40 INFO - mozversion INFO | platform_version: 45.0a1 15:42:40 INFO - 2015-11-11 15:42:40,601 DEBUG : using testdate: 1447285360 15:42:40 INFO - 2015-11-11 15:42:40,601 DEBUG : actual date: 1447285360 15:42:40 INFO - 2015-11-11 15:42:40,652 INFO : starting webserver on 'localhost:55186' 15:42:40 INFO - 2015-11-11 15:42:40,652 INFO : Starting test suite talos-linux64-ix-046.e 15:42:40 INFO - 2015-11-11 15:42:40,652 INFO : Starting test dromaeo_css 15:42:40 INFO - 2015-11-11 15:42:40,652 DEBUG : operating with platform_type : linux_ 15:42:40 INFO - 2015-11-11 15:42:40,653 INFO : Initialising browser for dromaeo_css test... 15:42:40 INFO - 2015-11-11 15:42:40,660 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Hedyr/profile http://localhost:55186/getInfo.html 15:42:45 INFO - 2015-11-11 15:42:45,320 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:42:45 INFO - 2015-11-11 15:42:45,321 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:42:45 INFO - 2015-11-11 15:42:45,321 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:42:45 INFO - 2015-11-11 15:42:45,321 DEBUG : BROWSER_OUTPUT: __metrics 15:42:46 INFO - 2015-11-11 15:42:46,425 INFO : Browser initialized. 15:42:46 INFO - 2015-11-11 15:42:46,425 INFO : Running cycle 1/1 for dromaeo_css test... 15:42:46 INFO - 2015-11-11 15:42:46,426 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Hedyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:42:58 INFO - 2015-11-11 15:42:58,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 15:42:58 INFO - 2015-11-11 15:42:58,381 DEBUG : BROWSER_OUTPUT: 15:43:48 INFO - 2015-11-11 15:43:48,066 DEBUG : BROWSER_OUTPUT: 1447285428058 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] 15:45:59 INFO - 2015-11-11 15:45:59,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55186/tests/dromaeo/cssquery-ext.html) 15:46:00 INFO - 2015-11-11 15:46:00,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 144228352 15:46:00 INFO - 2015-11-11 15:46:00,749 DEBUG : BROWSER_OUTPUT: 15:49:02 INFO - 2015-11-11 15:49:02,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-ext.html (next: http://localhost:55186/tests/dromaeo/cssquery-jquery.html) 15:49:03 INFO - 2015-11-11 15:49:03,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 142405632 15:49:03 INFO - 2015-11-11 15:49:03,323 DEBUG : BROWSER_OUTPUT: 15:52:05 INFO - 2015-11-11 15:52:05,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55186/tests/dromaeo/cssquery-mootools.html) 15:52:05 INFO - 2015-11-11 15:52:05,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 141991936 15:52:05 INFO - 2015-11-11 15:52:05,724 DEBUG : BROWSER_OUTPUT: 15:55:07 INFO - 2015-11-11 15:55:07,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55186/tests/dromaeo/cssquery-prototype.html) 15:55:08 INFO - 2015-11-11 15:55:08,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 138502144 15:55:08 INFO - 2015-11-11 15:55:08,085 DEBUG : BROWSER_OUTPUT: 15:58:10 INFO - 2015-11-11 15:58:10,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55186/tests/dromaeo/cssquery-yui.html) 15:58:11 INFO - 2015-11-11 15:58:11,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 139902976 15:58:11 INFO - 2015-11-11 15:58:11,246 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/dromaeo/cssquery-yui.html (next: http://localhost:55186/tests/dromaeo/cssquery-dojo.html) 16:01:13 INFO - 2015-11-11 16:01:13,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 142848000 16:01:13 INFO - 2015-11-11 16:01:13,647 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,648 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:01:13 INFO - 2015-11-11 16:01:13,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2643.088134593565;2703.243091934259;2711.8915243390265;2731.0441345529066;2749.0790585153973;4614.123316569858;4645.233536466488;4721.12659158056;4721.291806229063;4737.431508219019;4646.512116227798;4678.415198100238;4685.85942421727;4766.5471780180915;4781.952180478194;4349.891252718684;4369.169857727022;4435;4465.173942820572;4475.507694153657;4445.422095127629;4458.866234012985;4514.909701805962;4517.593416592506;4555.794989225493;4162.084341444877;4273.807678654437;4283.186194623012;4391.912161756747;4397.692161548693;4373.693841431101;4374.125174964988;4387.868363949086;4410.669199810027;4418.403515525395;4207.43199668044;4360.1279744051;4373.431453911003;4401.207782599131;4408.030233348658;4589.2886602576655;4621.075784843045;4733.976330118362;4739.099571081518;4763.499832517605;5123.897522049576;5154.381474223117;5169.612279079084;5171.663841850305;5206.635535512516;4918.311436398907;5074.771635276385;5195.350581177353;5204.635675502716;5211.739413029333;4653.418322709661;4706.811727530895;4716.38686970695;4744.7390393528685;4769.902922327884;5217.556507696812;5226.425093239741;5227.895442091137;5236.6334356595435;5291.391489978701;4770.522947705202;4997.425296090923;5014.724190169502;5031.119554078022;5041.823536176216;5026.170681837529;5035.77339019745;5080.54275115234;5131.948680513147;5177.818776342885;5027.296178535008;5063.063333283354;5081.9745901271;5117.692938423706;5120.846374608767;4852.102361063215;4980.8754781130765;5079.720615366116;5089.389273287229;5094.108531007059;4162.167566486654;4229.217594744982;4229.577042295808;4244.957550424456;4246.4691913510815;3712.7029837612927;3730.757500762442;3735.0662334416397;3739.08392443853;3759.774413535197;4257.233697934402;4290.420793192941;4358.934615980763;4447.555244475527;4461.08547747711;5165.405978312542;5166.715830629351;5180.533751962342;5186.273921650972;5212.55693266069;4475;4479.955200447954;4486.846313769409;4515.887102822456;4524.8416305429155;4354.259775838115;4477.753723545236;4490.820367185276;4543.818247270138;4619.95380046202;4903.877403064952;4917.434495033045;4936.407631084149;4942.184539551077;4988.152014157529;5191.558717509054;5214.061468935628;5214.165733482625;5215.269862219368;5218;4720.881977950578;4813.4945830687275;4842.757862106951;4875.268709693574;4906.950930490792;5048.318477005704;5092.719900405513;5094.337736094284;5104.515071068243;5138.152204886152;4906.411230652345;5157.819476318311;5176.1200595898035;5179.404368497671;5185.144451165515;4846.781894814812;4874;4888.60891128716;4893.266010098514;4901.3383193268455;5027.849164524924;5063;5074.416442109205;5079.136546787129;5085.262636917701;4964.528369804862;4982.202847544376;4989.501049894981;4992.201247800334;5008.774605142705;4865.0756356292195;4915.26271059344;5009.924851127309;5036.169032109808;5099.847004589868;4920.384951881015;4924.852254432372;4938.185199442052;4959.380077490314;4994.650374473752 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.6310109125794;546;556.9387367389586;565.3187908570171;570.0366380816423;35780.64219357806;36535.63464365362;36541.451878221815;36552.45171322432;36610;39101.21797564047;39465.802670986675;39527.80236098816;39705.20589588206;39848.20303593927;7696.692132314714;7980.241877021674;7993.800154996143;7995.520268783892;8022.879656805123;7784.961075194616;7884.64519096642;7894.921050789505;7905.723299684512;7932.841343173133;7782.494137881048;7793.532388056707;7875.094364148111;7892.131865494791;7894.328982036505;7773.494722843026;7838.176991415876;7845.254700803414;7854.253845884689;7884.881726774103;7740.071191457061;7825.569593672346;7877.724279650185;7883.645235964395;7923.247291507298;36248.81875590605;36621.63378366236;36685;36793.08017299562;36825.63174368276;2634.2755742171057;2650.2976711171555;2692.17888543994;2835.801493895428;3081.4299354619466;25688.486230275288;25692.486150277076;26054.218373448828;26382.07662731795;26742.866285668642;2675.381698433294;2738;2741.629879966219;2755.76575991041;2757.131503576367;215708;217755;218517.9999999984;218788;219231;47498.52501474941;48515.75742121267;56218;57234.42765572374;57452.13821792677;54155;54161.45838541643;54395;54407.72796135994;54420;11677.824832627517;11685.065194784396;11786.233894796811;11794.52821887115;11812.527498899948;8488.108748581433;8519.062903080656;8550.74347769568;8567.614457349435;8569.057403685589;16787.83212167887;17028.914855425643;17092;17119.74320385195;17120.40078597243;7040.823979400454;7244.384227340735;7269.454790890599;7277.19950805411;7310.488265821447;826;827.5696637748338;835.6949713354581;876.9342299327576;877.863931090682;22529.88735056314;22777.658335124986;22787;22810;22924.19765308206;921.5115988526092;935.0462528221312;945.163530275711;967.3325405470343;1024.779672370444;12458.75082498345;12496.50013999448;12556.686082848002;13145.34273286351;13610.455581776618;262735;263872;264590;265874;266041;41417.378739318934;41417.79291103585;41468;41623.37564936528;41681.79159104185;1116.8715597706205;1185.4013723069968;1196.3898411809867;1198.8261702053153;1199.6700907250577;25606.359841004123;25895.870520647277;26013.73986260113;26106.73893261043;26296.8685156573;38397.42403864;38468.6153138465;38622.80688596539;38744.41883371808;38928;244901;248375;248544;248597;248638;23703.407414814767;24453.51092978166;24474.26577202687;27390.45219095647;27885.302867428476;33595.83202083974;34008.489872652426;34243.31513369769;34906.30187396289;35058.298834022666;29135.125946221648;29164;29347.119586412442;29744;30050.69949300479;29126.27184320409;29354.266143346587;30556.388872222877;31504.527432088078;31745.20636984094;30762.692373075985;30946.53580196254;31119.37761244717;31326.37347253088;31341.216469588442;26978.730212698407;28637.570436443886;29086;29716.55425168581;29943.85028074846;21031.684524731834;23167.884160579088;23821.642675359537;24142.517149656556;25449.236522904343 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.3723193476102;339.64507090090854;339.7808413573245;339.8691503771048;342.32220203996087;12429.192102513352;12798.424070916808;13039.152455090412;15140.318685659144;15215.46745863895;14821.481248156317;15158.85339950768;16192.271347789349;16408.26162822673;16414.17929103546;5014.648974571782;5063.544281014708;5206.193040078775;5215;5215.687058776467;5018.071656743514;5054;5070.366204224472;5092.541671249587;5101.464346243628;4548.385967894325;4694.929576056362;4695.17834378984;5032.7735251913755;5035.169197082477;4638;4641.071785642885;4645.721256724591;4658.9068218635775;4671.719696818185;3983.900402489961;4143.274926887782;4143.274926887782;4144.834206631731;4167.791610419497;11754.177207595472;12061.095417843697;12140.757184856253;12536;12637.052221083455;1712.7773389459414;1729.1786401459206;1746.772919520467;1772.0342413384608;1994.9426803794013;8923.375363724477;9080.954595227047;9150.679726209617;9200;9321.813563728756;1539.8383169767126;1570.2384343593349;1585.8969167004223;1611.589044793582;1616.0869108953405;46994.29508557374;47897.76051119722;53078.20382694263;53089.46910530884;53225.7338713304;6428.453581445536;6635.137432133792;6689.4982876284475;6710.463162946952;6748.561343512754;7468.103827540621;7569.697212111564;7605.429592780563;7765.262300081483;7791.649375778104;4693.436787585511;4743.525647435229;4792.520747925179;4802.783874725646;4824.445188803333;4720.386349774507;4746.169420351424;4748.264019077049;4760.64295177863;4768.213244814567;3030.848457577112;3033.3326668132977;3058.1895797613206;3086.5678804967324;3086.6758990306143;1084.9945750271356;1086.9565217391216;1088.515610553312;1089.05796486039;1143.5597295041468;421.3153625358792;458.8921603423193;463.40452518513547;465.52748959805825;477.3365022618563;10332.276740628084;10370.948145259226;10474.68575942723;10571.15430765537;10584.682459526226;428.9764062976504;438.7367579452303;439.9032212913154;445.7860227091015;455.40569556728127;5584.944150558443;5801.361850196475;5862.736176872051;5910.704464776744;5932.762689492372;484081;486125;487677;487875;492734;65358.67320663366;66036.66981665061;66671.33328666652;66991;67822.3217767816;507.34805774580224;508.37469912008436;510.04875906434233;514.2902794144057;514.4983640950119;9603.231741460806;9753.268504862306;9806.166475849634;9838.212942964688;9845.458499782295;29951.700482995762;30040.09879703525;33192.83403582966;33226.169345766546;33745.83127084349;37788.43317350187;38526.80736596299;42768.572314277706;43521.12957740891;43596.34605480857;5619.213310136666;6127.877442451037;6287.591306565058;6329.050642403677;6336.58812177207;10805.675829725122;11011.339319640847;11012.559497620005;11052.11583073336;11146.665600031687;2316.386157668253;8454.957725211334;9436.150746432853;9913.801723965624;10082.546285417027;9337.325349301398;9758.268129890144;9852.310338276251;9933.552990115317;10141.847872281774;9931;9973.50132493387;10102.646407375707;10257.025582569644;10265.897341026794;5683.635927377482;6209.472194863487;6244.125822384961;6257.342978987323;6261.68691565429;9778.511074446391;9939.950300248742;9963.452010139223;10012.599496020077;10023.849642255518 16:01:13 INFO - 2015-11-11 16:01:13,649 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1212.9757404851903;1287.3820566128256;1291.5415027665179;1612.7661489084076;1624.8456396642314;6804.319568043194;6866.759663411769;6913.308669133085;6928.237893831674;6932.792016239515;7098.254683258261;7130.75042373517;7140.678669459874;7165.892511612317;7209.567425954447;2026.473116989586;2033.5119571302855;2036.3178335257705;2048.72342233798;2059.794020597943;2053.3634573282256;2075.968860467094;2093.7173481579944;2109.48317662173;2113.7991890770354;1998.5003749062735;2065.163608738463;2084.135083940163;2084.9791502085013;2088.2899814063217;1982.1575830272077;2018.0616013553622;2018.3944816554974;2018.656828339186;2018.7476565429322;2036.216056818121;2115.270231770037;2132.3070002249174;2133.9466513337134;2136.102836808544;7083.822904427379;7135;7160.713571457136;7160.785176444715;7177.605231712254;4096.139810639769;4165.708400411972;4172.269852775752;4203.936940945889;4211.178820130076;2759.5446751286013;2782.9721702783118;2812.2125804774696;2821.5767634854733;2828.0950095969297;904.4799240436776;917.0462718772469;921.7188757428981;944.551338114397;970.8252514547379;9452.291078169164;9545.713628591084;9574.234061275081;9589.520523973843;9610.51947402627;3732.1789206374556;3801.4107813288983;3818.3317919364;3845.5193100862393;3870.6129387061633;7622;7647;7661.846763064707;7667.616619169131;7675.961620191863;4174.5616710245595;4181.456410666594;4184.4141820145205;4186.727862688916;4210.90516465715;3838.3666694995572;3848.191879705237;3851.326017946848;3862.5558060822805;3868.1876805871084;3016.8189908605555;3162.177833763238;3168.3663267346624;3176.729977951854;3180.268538236219;932.8414169591185;934.8317302885546;938.1884669760608;941.0260380506144;942.072059021863;822.7696245051395;827.995860020696;828.5608627427473;872.7207293665966;956.5408603870043;6330.68346582669;6368;6421.486281097501;6436.485081193493;6440.4847612190915;1020.0921180149672;1035.425338936882;1047.9528421221064;1050.1965996013057;1053.7839742852698;5158;5204.713740744295;5206.817761378409;5213.817516386984;5230.241614965808;8152.714654987047;8347.373946954003;8452.366072544584;8475.915240847513;8598.355123365773;8416.2004609562;8446.957765211257;8515.361347898932;8527;8634.740957771277;6526.379993900572;6663.5335526513645;6666;6727.9327206728285;6767.018782276542;6595.868082638416;6648;6671.39957403836;6673.733050677918;6674.666266686743;7461.477696561188;7644.426667999811;7675.270849269311;7682.385409167141;7684.039495063117;7644.36809619894;7725.922740772745;7746.728864489716;7771.689132434639;7775.300222979959;6158.107074474266;6162.7534898605345;6221.502279817694;6226.003839385677;6237.376262373727;6451.258105317761;6502.8461196320695;6508.284088750139;6560.114384558215;6567.113439685581;6168.0439531872635;6169.413905678954;6280.434760871543;6358.809235722936;6384.680765961591;5608.6073974823;5779.219805326227;6235.3452887446165;6311.747530098744;6391.936080639134;6355.428011478989;6359.872802544016;6366.204224471941;6383.39357761012;6418.1656384669695;5935.7032148391545;5967.492763115184;5968.194293770285;5989.970050149721;6007.098935159761;5905.291365036223;6020.458158765557;6029.3669164737075;6060.939390606214;6065.4541091302 16:01:13 INFO - 2015-11-11 16:01:13,650 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.9402119576085;304.66030376130624;309.20996853040475;309.7692219296623;310.2631250779399;5324.3610766708;5379.058664733676;5404.243405923174;5442.8911421771545;5471.808486702967;5255.159174532076;5293.258943747869;5319.361676598804;5333.093374126398;5344.331958505187;4020.7587544747407;4105.2815757242515;4107.7535347879075;4115.156392939455;4122.381642753596;4088.1823635272917;4089.5501494835544;4112.485939257593;4115.42384066231;4115.54728979812;4059.7158198926086;4060.086480541869;4063.918721625566;4064.146529228851;4069.2065047315637;4050.351943689025;4063.7358571692894;4067.3085575452246;4074.9592504074876;4076.0421300994244;3496.7552271341015;3552.5381700379044;3553.8045407502577;3556.928861422757;3585.354636165489;5067.518585734386;5097.515736005073;5118.872028199287;5154.768035438415;5157.30376399185;4627.028324051953;4628.699134556243;4631.258998560214;4657.138429390539;4658.510856360102;5502.0371434999115;5512.972435137799;5518.227448157261;5533.944660553383;5537.0863807471715;3793.696504279651;3846.6538011578814;3850.1144736710435;3850.403187505941;3854.0557563396865;5669.546436285087;5816.447437493432;5900.380460051676;5902.468777810018;5906.5570082244;4024.678025757932;4024.71826972115;4025.4364388985564;4027.134166154291;4027.7180597357906;4084.81618327176;4093.16090201508;4094.836206551764;4099.0162361033135;4100.036491424513;4669.976650116728;4676.485586585472;4678.789454474557;4679.99380133273;4680.391549098664;5406.459354064562;5441.510264076173;5505.229267902497;5514.834554963358;5515.641483303652;1421.7654087075723;1443.444273954514;1444.2706433251142;1444.3283872999107;1444.9422023118957;970.9902900971041;984.2962281968427;994.6469003503797;1002.659095907395;1007.1338648762058;4891.559759621651;4897;4899.608031357554;4905.583025442877;4973.079980203674;5834.154047663065;5834.766609335664;5836.358000619928;5849.298084229919;5854.121881717691;4960.181570040902;4963.329950456714;4966.453690094087;4966.826161084345;4969.229769385751;3162.304293055524;3197.7921435106646;3219.742420606346;3225.1130938991496;3229.5963004624423;5490.972545137249;5491.945080549223;5494.752736126884;5494.945050549523;5501.312335958005;5968.194293770285;5972.402759723993;5973.253343332083;5973.850653733692;5986.640801551921;5476.096444086681;5484.561235101182;5487.6981766003255;5491.121420572689;5496.258005169331;5639.971800140973;5852.414758524284;5889.116632505158;5896.027155519291;5903.173555702119;5704.914426283692;5718.485336319751;5720.713964301852;5757.481826635623;5785.508231800344;5549;5551.528120109836;5574.581906356958;5576;5581;3964.861229856941;3984.900377490586;4048.3117869962766;4063.471748672772;4066.390041493681;5734.3978882218435;5807.883842323045;5909.527237820878;5910.231669882888;5911.290645122613;5567.944320556742;5571.721413929368;5578.748956297058;5604.8318550443555;5616.775328986795;5574.832755017356;5578.721063946868;5594.776208951759;5598.972005139948;5613.24221230145;5369.140937449989;5488.204210389391;5492.395836458067;5497.3952865184;5509;5621.80323688669;5684.602077854511;5698.971505142447;5712.057510510719;5714.628549144292;5545.334559852843;5553.666779993213;5555.583331250092;5557.277553917965;5559.63862348946 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: |5;yui.html;603.5382932056975;707.8831992721201;760.6120878352042;763.725058978768;765.877459606463;10448.425336606484;10611.469426528662;10619.044286014258;10703.83944240836;10727.302725322857;11679;11758.647240582775;11781.057515398768;11784.587539436121;11877.940610296937;596.9641821490703;602.1479606357;726.5422783646309;735.5549892315153;747.4020783373306;741.4550305525435;745.7427187620262;750.0399488654504;751.0761763031475;751.8233215194425;791.5923299500762;795.5425630262594;797.2784629909941;797.6849144587884;800.5596921693075;788.1527358090048;788.1999770233218;788.4953629677011;788.5505262000662;790.1308560583399;570.1220121013635;576.6655339902846;577.9797707080274;578.6441338576788;580.8344621782813;11233.32600044;11352.148588855785;11353.943230283796;11365.602203922823;11374.203805733601;8927.598258078402;8957.238634715992;9052.8642070369;9297.442153470813;9340.20608248293;8863.335249856222;8920.821583568293;8995.370324077317;9023.323250756153;9185.081491850828;2779.4580056888913;2800.6079148919166;2804.5092108880863;2807.466581349537;2821.2664707176077;39862.402063969064;40297.79851100755;40389.19221615551;40443.39334909979;40445.595544044474;6696.363845434774;6701.229358623723;6786.524943254023;6842.178938527409;6944.583325000516;10260.127889129359;10272;10277.94861025705;10292.176625869912;10313.48432578368;5398.4871437213405;5414.242006119146;5578;5654.717264136777;5799.33307669615;3504.141485336109;3515.33208690348;3532.947005794915;3558.5018097466377;3621.8913432597064;2472.9010839566577;2488.4525404411;2488.4525404411;2511.54792137417;2515.7861581765387;388.793939212218;391.0829105747019;393.3215203773525;397.37810326838405;397.97015223858324;446.5422941485004;466.55444050931277;471.9362886010413;528.4319356691495;559.2589818490517;7790.454668173174;7894.723684671009;7961.960190199012;8035.879461808077;8041.236082572146;423.4368290174061;467.8081986385566;478.56928764112575;481.65320968902336;510.50226029621564;3644.4168932970597;3655.8354874030733;3823.388257878726;3914.9608503914596;3933.2330195612153;49455.25817112746;50167;50359.49640503621;51164.23253651198;51523.48476515262;42190.57809421928;42339.15321693549;43395.56604433915;43489.347659785126;43523.78238108789;42238.15523689509;42448;42728.35907461391;42931.35602965958;43168.78415607902;8031.357491400557;8338.499690018618;8522.957385213034;8572.571371431279;8621.82756344857;30077.248068798453;30175.245618859703;30415.847920760254;30544.694553054185;30563.847180763954;38748.6125138745;39185.49366822738;39671.00822479461;39965;40084.59915400809;6980.895286570807;6990.825229369103;7155.3202445767565;7246.5289756165685;7460.776176714708;11326.433678316216;11333.376664283544;11346.773064538827;11598.478068487108;11627.418629068681;10772.773032184868;10888;10937.671869843918;10997.780044399227;11054.944725276322;10107.69676909694;10142.137918276734;10251.179905607683;10323.32898361604;10615.946920265349;10619.893801062199;10686.198535110054;10730.087942524973;10896.12830973536;10951.123910087015;9043.140901614335;9071.923567258333;9260.166585007382;9456.2907781918;9457.148856602938;8890.777730556787;9043.773905652148;9119.361644684808;9216.151076639164;9228.40015398997 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1447286473640__endTimestamp 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,652 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4719.00 Median:4874.00 stddev:505.16 (10.4%) stddev-sans-first:479.74 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: Values: 2643.1 2703.2 2711.9 2731.0 2749.1 4614.1 4645.2 4721.1 4721.3 4737.4 4646.5 4678.4 4685.9 4766.5 4782.0 4349.9 4369.2 4435.0 4465.2 4475.5 4445.4 4458.9 4514.9 4517.6 4555.8 4162.1 4273.8 4283.2 4391.9 4397.7 4373.7 4374.1 4387.9 4410.7 4418.4 4207.4 4360.1 4373.4 4401.2 4408.0 4589.3 4621.1 4734.0 4739.1 4763.5 5123.9 5154.4 5169.6 5171.7 5206.6 4918.3 5074.8 5195.4 5204.6 5211.7 4653.4 4706.8 4716.4 4744.7 4769.9 5217.6 5226.4 5227.9 5236.6 5291.4 4770.5 4997.4 5014.7 5031.1 5041.8 5026.2 5035.8 5080.5 5131.9 5177.8 5027.3 5063.1 5082.0 5117.7 5120.8 4852.1 4980.9 5079.7 5089.4 5094.1 4162.2 4229.2 4229.6 4245.0 4246.5 3712.7 3730.8 3735.1 3739.1 3759.8 4257.2 4290.4 4358.9 4447.6 4461.1 5165.4 5166.7 5180.5 5186.3 5212.6 4475.0 4480.0 4486.8 4515.9 4524.8 4354.3 4477.8 4490.8 4543.8 4620.0 4903.9 4917.4 4936.4 4942.2 4988.2 5191.6 5214.1 5214.2 5215.3 5218.0 4720.9 4813.5 4842.8 4875.3 4907.0 5048.3 5092.7 5094.3 5104.5 5138.2 4906.4 5157.8 5176.1 5179.4 5185.1 4846.8 4874.0 4888.6 4893.3 4901.3 5027.8 5063.0 5074.4 5079.1 5085.3 4964.5 4982.2 4989.5 4992.2 5008.8 4865.1 4915.3 5009.9 5036.2 5099.8 4920.4 4924.9 4938.2 4959.4 4994.7 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39302.93 Median:32670.52 stddev:63759.51 (195.2%) stddev-sans-first:63871.96 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: Values: 542.6 546.0 556.9 565.3 570.0 35780.6 36535.6 36541.5 36552.5 36610.0 39101.2 39465.8 39527.8 39705.2 39848.2 7696.7 7980.2 7993.8 7995.5 8022.9 7785.0 7884.6 7894.9 7905.7 7932.8 7782.5 7793.5 7875.1 7892.1 7894.3 7773.5 7838.2 7845.3 7854.3 7884.9 7740.1 7825.6 7877.7 7883.6 7923.2 36248.8 36621.6 36685.0 36793.1 36825.6 2634.3 2650.3 2692.2 2835.8 3081.4 25688.5 25692.5 26054.2 26382.1 26742.9 2675.4 2738.0 2741.6 2755.8 2757.1 215708.0 217755.0 218518.0 218788.0 219231.0 47498.5 48515.8 56218.0 57234.4 57452.1 54155.0 54161.5 54395.0 54407.7 54420.0 11677.8 11685.1 11786.2 11794.5 11812.5 8488.1 8519.1 8550.7 8567.6 8569.1 16787.8 17028.9 17092.0 17119.7 17120.4 7040.8 7244.4 7269.5 7277.2 7310.5 826.0 827.6 835.7 876.9 877.9 22529.9 22777.7 22787.0 22810.0 22924.2 921.5 935.0 945.2 967.3 1024.8 12458.8 12496.5 12556.7 13145.3 13610.5 262735.0 263872.0 264590.0 265874.0 266041.0 41417.4 41417.8 41468.0 41623.4 41681.8 1116.9 1185.4 1196.4 1198.8 1199.7 25606.4 25895.9 26013.7 26106.7 26296.9 38397.4 38468.6 38622.8 38744.4 38928.0 244901.0 248375.0 248544.0 248597.0 248638.0 23703.4 24453.5 24474.3 27390.5 27885.3 33595.8 34008.5 34243.3 34906.3 35058.3 29135.1 29164.0 29347.1 29744.0 30050.7 29126.3 29354.3 30556.4 31504.5 31745.2 30762.7 30946.5 31119.4 31326.4 31341.2 26978.7 28637.6 29086.0 29716.6 29943.9 21031.7 23167.9 23821.6 24142.5 25449.2 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,653 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24260.55 Median:25844.74 stddev:79837.50 (308.9%) stddev-sans-first:80041.25 16:01:13 INFO - 2015-11-11 16:01:13,654 DEBUG : BROWSER_OUTPUT: Values: 338.4 339.6 339.8 339.9 342.3 12429.2 12798.4 13039.2 15140.3 15215.5 14821.5 15158.9 16192.3 16408.3 16414.2 5014.6 5063.5 5206.2 5215.0 5215.7 5018.1 5054.0 5070.4 5092.5 5101.5 4548.4 4694.9 4695.2 5032.8 5035.2 4638.0 4641.1 4645.7 4658.9 4671.7 3983.9 4143.3 4143.3 4144.8 4167.8 11754.2 12061.1 12140.8 12536.0 12637.1 1712.8 1729.2 1746.8 1772.0 1994.9 8923.4 9081.0 9150.7 9200.0 9321.8 1539.8 1570.2 1585.9 1611.6 1616.1 46994.3 47897.8 53078.2 53089.5 53225.7 6428.5 6635.1 6689.5 6710.5 6748.6 7468.1 7569.7 7605.4 7765.3 7791.6 4693.4 4743.5 4792.5 4802.8 4824.4 4720.4 4746.2 4748.3 4760.6 4768.2 3030.8 3033.3 3058.2 3086.6 3086.7 1085.0 1087.0 1088.5 1089.1 1143.6 421.3 458.9 463.4 465.5 477.3 10332.3 10370.9 10474.7 10571.2 10584.7 429.0 438.7 439.9 445.8 455.4 5584.9 5801.4 5862.7 5910.7 5932.8 484081.0 486125.0 487677.0 487875.0 492734.0 65358.7 66036.7 66671.3 66991.0 67822.3 507.3 508.4 510.0 514.3 514.5 9603.2 9753.3 9806.2 9838.2 9845.5 29951.7 30040.1 33192.8 33226.2 33745.8 37788.4 38526.8 42768.6 43521.1 43596.3 5619.2 6127.9 6287.6 6329.1 6336.6 10805.7 11011.3 11012.6 11052.1 11146.7 2316.4 8455.0 9436.2 9913.8 10082.5 9337.3 9758.3 9852.3 9933.6 10141.8 9931.0 9973.5 10102.6 10257.0 10265.9 5683.6 6209.5 6244.1 6257.3 6261.7 9778.5 9940.0 9963.5 10012.6 10023.8 16:01:13 INFO - 2015-11-11 16:01:13,654 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,654 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4902.13 Median:6296.09 stddev:2539.53 (40.3%) stddev-sans-first:2531.52 16:01:13 INFO - 2015-11-11 16:01:13,654 DEBUG : BROWSER_OUTPUT: Values: 1213.0 1287.4 1291.5 1612.8 1624.8 6804.3 6866.8 6913.3 6928.2 6932.8 7098.3 7130.8 7140.7 7165.9 7209.6 2026.5 2033.5 2036.3 2048.7 2059.8 2053.4 2076.0 2093.7 2109.5 2113.8 1998.5 2065.2 2084.1 2085.0 2088.3 1982.2 2018.1 2018.4 2018.7 2018.7 2036.2 2115.3 2132.3 2133.9 2136.1 7083.8 7135.0 7160.7 7160.8 7177.6 4096.1 4165.7 4172.3 4203.9 4211.2 2759.5 2783.0 2812.2 2821.6 2828.1 904.5 917.0 921.7 944.6 970.8 9452.3 9545.7 9574.2 9589.5 9610.5 3732.2 3801.4 3818.3 3845.5 3870.6 7622.0 7647.0 7661.8 7667.6 7676.0 4174.6 4181.5 4184.4 4186.7 4210.9 3838.4 3848.2 3851.3 3862.6 3868.2 3016.8 3162.2 3168.4 3176.7 3180.3 932.8 934.8 938.2 941.0 942.1 822.8 828.0 828.6 872.7 956.5 6330.7 6368.0 6421.5 6436.5 6440.5 1020.1 1035.4 1048.0 1050.2 1053.8 5158.0 5204.7 5206.8 5213.8 5230.2 8152.7 8347.4 8452.4 8475.9 8598.4 8416.2 8447.0 8515.4 8527.0 8634.7 6526.4 6663.5 6666.0 6727.9 6767.0 6595.9 6648.0 6671.4 6673.7 6674.7 7461.5 7644.4 7675.3 7682.4 7684.0 7644.4 7725.9 7746.7 7771.7 7775.3 6158.1 6162.8 6221.5 6226.0 6237.4 6451.3 6502.8 6508.3 6560.1 6567.1 6168.0 6169.4 6280.4 6358.8 6384.7 5608.6 5779.2 6235.3 6311.7 6391.9 6355.4 6359.9 6366.2 6383.4 6418.2 5935.7 5967.5 5968.2 5990.0 6007.1 5905.3 6020.5 6029.4 6060.9 6065.5 16:01:13 INFO - 2015-11-11 16:01:13,655 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,655 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4648.84 Median:5328.73 stddev:1367.83 (25.7%) stddev-sans-first:1332.13 16:01:13 INFO - 2015-11-11 16:01:13,655 DEBUG : BROWSER_OUTPUT: Values: 298.9 304.7 309.2 309.8 310.3 5324.4 5379.1 5404.2 5442.9 5471.8 5255.2 5293.3 5319.4 5333.1 5344.3 4020.8 4105.3 4107.8 4115.2 4122.4 4088.2 4089.6 4112.5 4115.4 4115.5 4059.7 4060.1 4063.9 4064.1 4069.2 4050.4 4063.7 4067.3 4075.0 4076.0 3496.8 3552.5 3553.8 3556.9 3585.4 5067.5 5097.5 5118.9 5154.8 5157.3 4627.0 4628.7 4631.3 4657.1 4658.5 5502.0 5513.0 5518.2 5533.9 5537.1 3793.7 3846.7 3850.1 3850.4 3854.1 5669.5 5816.4 5900.4 5902.5 5906.6 4024.7 4024.7 4025.4 4027.1 4027.7 4084.8 4093.2 4094.8 4099.0 4100.0 4670.0 4676.5 4678.8 4680.0 4680.4 5406.5 5441.5 5505.2 5514.8 5515.6 1421.8 1443.4 1444.3 1444.3 1444.9 971.0 984.3 994.6 1002.7 1007.1 4891.6 4897.0 4899.6 4905.6 4973.1 5834.2 5834.8 5836.4 5849.3 5854.1 4960.2 4963.3 4966.5 4966.8 4969.2 3162.3 3197.8 3219.7 3225.1 3229.6 5491.0 5491.9 5494.8 5494.9 5501.3 5968.2 5972.4 5973.3 5973.9 5986.6 5476.1 5484.6 5487.7 5491.1 5496.3 5640.0 5852.4 5889.1 5896.0 5903.2 5704.9 5718.5 5720.7 5757.5 5785.5 5549.0 5551.5 5574.6 5576.0 5581.0 3964.9 3984.9 4048.3 4063.5 4066.4 5734.4 5807.9 5909.5 5910.2 5911.3 5567.9 5571.7 5578.7 5604.8 5616.8 5574.8 5578.7 5594.8 5599.0 5613.2 5369.1 5488.2 5492.4 5497.4 5509.0 5621.8 5684.6 5699.0 5712.1 5714.6 5545.3 5553.7 5555.6 5557.3 5559.6 16:01:13 INFO - 2015-11-11 16:01:13,655 DEBUG : BROWSER_OUTPUT: 16:01:13 INFO - 2015-11-11 16:01:13,655 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11792.54 Median:21985.16 stddev:13908.98 (63.3%) stddev-sans-first:13922.62 16:01:13 INFO - 2015-11-11 16:01:13,656 DEBUG : BROWSER_OUTPUT: Values: 603.5 707.9 760.6 763.7 765.9 10448.4 10611.5 10619.0 10703.8 10727.3 11679.0 11758.6 11781.1 11784.6 11877.9 597.0 602.1 726.5 735.6 747.4 741.5 745.7 750.0 751.1 751.8 791.6 795.5 797.3 797.7 800.6 788.2 788.2 788.5 788.6 790.1 570.1 576.7 578.0 578.6 580.8 11233.3 11352.1 11353.9 11365.6 11374.2 8927.6 8957.2 9052.9 9297.4 9340.2 8863.3 8920.8 8995.4 9023.3 9185.1 2779.5 2800.6 2804.5 2807.5 2821.3 39862.4 40297.8 40389.2 40443.4 40445.6 6696.4 6701.2 6786.5 6842.2 6944.6 10260.1 10272.0 10277.9 10292.2 10313.5 5398.5 5414.2 5578.0 5654.7 5799.3 3504.1 3515.3 3532.9 3558.5 3621.9 2472.9 2488.5 2488.5 2511.5 2515.8 388.8 391.1 393.3 397.4 398.0 446.5 466.6 471.9 528.4 559.3 7790.5 7894.7 7962.0 8035.9 8041.2 423.4 467.8 478.6 481.7 510.5 3644.4 3655.8 3823.4 3915.0 3933.2 49455.3 50167.0 50359.5 51164.2 51523.5 42190.6 42339.2 43395.6 43489.3 43523.8 42238.2 42448.0 42728.4 42931.4 43168.8 8031.4 8338.5 8523.0 8572.6 8621.8 30077.2 30175.2 30415.8 30544.7 30563.8 38748.6 39185.5 39671.0 39965.0 40084.6 6980.9 6990.8 7155.3 7246.5 7460.8 11326.4 11333.4 11346.8 11598.5 11627.4 10772.8 10888.0 10937.7 10997.8 11054.9 10107.7 10142.1 10251.2 10323.3 10615.9 10619.9 10686.2 10730.1 10896.1 10951.1 9043.1 9071.9 9260.2 9456.3 9457.1 8890.8 9043.8 9119.4 9216.2 9228.4 16:01:13 INFO - 2015-11-11 16:01:13,656 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:01:13 INFO - 2015-11-11 16:01:13,656 DEBUG : BROWSER_OUTPUT: 16:01:14 INFO - 2015-11-11 16:01:14,313 INFO : Browser exited with error code: 0 16:01:14 INFO - 2015-11-11 16:01:14,329 INFO : Completed test dromaeo_css (00:18:33) 16:01:14 INFO - 2015-11-11 16:01:14,330 INFO : Starting test kraken 16:01:14 INFO - 2015-11-11 16:01:14,330 DEBUG : operating with platform_type : linux_ 16:01:14 INFO - 2015-11-11 16:01:14,330 INFO : Initialising browser for kraken test... 16:01:14 INFO - 2015-11-11 16:01:14,336 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQv2Ock/profile http://localhost:55186/getInfo.html 16:01:18 INFO - 2015-11-11 16:01:18,778 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:01:18 INFO - 2015-11-11 16:01:18,778 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:01:18 INFO - 2015-11-11 16:01:18,778 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:01:18 INFO - 2015-11-11 16:01:18,778 DEBUG : BROWSER_OUTPUT: __metrics 16:01:19 INFO - 2015-11-11 16:01:19,765 INFO : Browser initialized. 16:01:19 INFO - 2015-11-11 16:01:19,766 INFO : Running cycle 1/1 for kraken test... 16:01:19 INFO - 2015-11-11 16:01:19,766 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQv2Ock/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:01:31 INFO - 2015-11-11 16:01:31,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 16:01:31 INFO - 2015-11-11 16:01:31,724 DEBUG : BROWSER_OUTPUT: 16:01:34 INFO - 2015-11-11 16:01:34,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55186/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:34 INFO - 2015-11-11 16:01:34,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 142245888 16:01:34 INFO - 2015-11-11 16:01:34,934 DEBUG : BROWSER_OUTPUT: 16:01:37 INFO - 2015-11-11 16:01:37,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55186/tests/kraken/driver.html?testName=audio-dft) 16:01:38 INFO - 2015-11-11 16:01:38,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 16:01:38 INFO - 2015-11-11 16:01:38,302 DEBUG : BROWSER_OUTPUT: 16:01:41 INFO - 2015-11-11 16:01:41,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55186/tests/kraken/driver.html?testName=audio-fft) 16:01:41 INFO - 2015-11-11 16:01:41,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 136183808 16:01:41 INFO - 2015-11-11 16:01:41,851 DEBUG : BROWSER_OUTPUT: 16:01:43 INFO - 2015-11-11 16:01:43,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55186/tests/kraken/driver.html?testName=audio-oscillator) 16:01:44 INFO - 2015-11-11 16:01:44,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 136749056 16:01:44 INFO - 2015-11-11 16:01:44,538 DEBUG : BROWSER_OUTPUT: 16:01:46 INFO - 2015-11-11 16:01:46,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:01:47 INFO - 2015-11-11 16:01:47,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 138063872 16:01:47 INFO - 2015-11-11 16:01:47,366 DEBUG : BROWSER_OUTPUT: 16:01:50 INFO - 2015-11-11 16:01:50,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55186/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:51 INFO - 2015-11-11 16:01:51,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 137936896 16:01:51 INFO - 2015-11-11 16:01:51,046 DEBUG : BROWSER_OUTPUT: 16:01:54 INFO - 2015-11-11 16:01:54,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55186/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:55 INFO - 2015-11-11 16:01:55,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 136355840 16:01:55 INFO - 2015-11-11 16:01:55,103 DEBUG : BROWSER_OUTPUT: 16:01:58 INFO - 2015-11-11 16:01:58,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55186/tests/kraken/driver.html?testName=json-parse-financial) 16:01:58 INFO - 2015-11-11 16:01:58,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 136601600 16:01:58 INFO - 2015-11-11 16:01:58,638 DEBUG : BROWSER_OUTPUT: 16:02:00 INFO - 2015-11-11 16:02:00,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:00 INFO - 2015-11-11 16:02:00,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 16:02:00 INFO - 2015-11-11 16:02:00,966 DEBUG : BROWSER_OUTPUT: 16:02:02 INFO - 2015-11-11 16:02:02,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:03 INFO - 2015-11-11 16:02:03,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 137768960 16:02:03 INFO - 2015-11-11 16:02:03,455 DEBUG : BROWSER_OUTPUT: 16:02:05 INFO - 2015-11-11 16:02:05,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:06 INFO - 2015-11-11 16:02:06,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 139513856 16:02:06 INFO - 2015-11-11 16:02:06,230 DEBUG : BROWSER_OUTPUT: 16:02:08 INFO - 2015-11-11 16:02:08,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:09 INFO - 2015-11-11 16:02:09,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 137986048 16:02:09 INFO - 2015-11-11 16:02:09,457 DEBUG : BROWSER_OUTPUT: 16:02:12 INFO - 2015-11-11 16:02:12,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:12 INFO - 2015-11-11 16:02:12,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 139788288 16:02:12 INFO - 2015-11-11 16:02:12,652 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55186/tests/kraken/driver.html?testName=ai-astar) 16:02:14 INFO - 2015-11-11 16:02:14,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 16:02:14 INFO - 2015-11-11 16:02:14,652 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:02:14 INFO - 2015-11-11 16:02:14,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:02:14 INFO - 2015-11-11 16:02:14,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:02:14 INFO - 2015-11-11 16:02:14,654 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:02:14 INFO - 2015-11-11 16:02:14,654 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;118;110;113;124;112;113;113;114 16:02:14 INFO - 2015-11-11 16:02:14,654 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;164;174;131;158;166;135;163;131 16:02:14 INFO - 2015-11-11 16:02:14,654 DEBUG : BROWSER_OUTPUT: |2;audio-dft;169;172;165;165;166;170;167;164;165;164 16:02:14 INFO - 2015-11-11 16:02:14,654 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;74;74;150;72;73;73;74;161 16:02:14 INFO - 2015-11-11 16:02:14,656 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;136;92;91;92;137;93;92;129 16:02:14 INFO - 2015-11-11 16:02:14,656 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;111;110;110;110;112;110;111;111 16:02:14 INFO - 2015-11-11 16:02:14,656 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;149;148;148;148;148;149;148;150;148 16:02:14 INFO - 2015-11-11 16:02:14,656 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;97;96;97;96;96;97;96 16:02:14 INFO - 2015-11-11 16:02:14,656 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;72;75;72;75;72;73;74 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;67;66;67;67;67;68;66;67 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;83;84;83;84;87;98;97 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;121;126;125;135;123;129;133;125;129 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;146;150;145;147;153;147;145;151;149 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;70;69;70;69;70;71;68;71 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,773 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: __startTimestamp1447286534653__endTimestamp 16:02:14 INFO - 2015-11-11 16:02:14,657 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:113.50 stddev:4.46 (3.9%) stddev-sans-first:4.68 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 118.0 110.0 113.0 124.0 112.0 113.0 113.0 114.0 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:160.50 stddev:17.06 (10.6%) stddev-sans-first:17.92 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 164.0 174.0 131.0 158.0 166.0 135.0 163.0 131.0 16:02:14 INFO - 2015-11-11 16:02:14,661 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:166.70 Median:166.50 stddev:2.75 (1.7%) stddev-sans-first:2.79 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: Values: 169.0 172.0 165.0 165.0 166.0 170.0 167.0 164.0 165.0 164.0 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.00 Median:74.00 stddev:34.63 (46.8%) stddev-sans-first:36.30 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 74.0 74.0 150.0 72.0 73.0 73.0 74.0 161.0 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:92.00 stddev:20.40 (22.2%) stddev-sans-first:21.20 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 136.0 92.0 91.0 92.0 137.0 93.0 92.0 129.0 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 111.0 110.0 110.0 110.0 112.0 110.0 111.0 111.0 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,662 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: Values: 147.0 149.0 148.0 148.0 148.0 148.0 149.0 148.0 150.0 148.0 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:73.00 stddev:1.25 (1.7%) stddev-sans-first:1.27 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 75.0 72.0 75.0 72.0 73.0 74.0 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 66.0 67.0 67.0 67.0 68.0 66.0 67.0 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.50 stddev:5.77 (6.8%) stddev-sans-first:5.95 16:02:14 INFO - 2015-11-11 16:02:14,663 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 83.0 84.0 83.0 84.0 87.0 98.0 97.0 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:129.00 stddev:4.57 (3.5%) stddev-sans-first:4.58 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: Values: 132.0 121.0 126.0 125.0 135.0 123.0 129.0 133.0 125.0 129.0 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:148.00 stddev:4.65 (3.1%) stddev-sans-first:2.80 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: Values: 136.0 146.0 150.0 145.0 147.0 153.0 147.0 145.0 151.0 149.0 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 69.0 70.0 69.0 70.0 71.0 68.0 71.0 16:02:14 INFO - 2015-11-11 16:02:14,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:02:14 INFO - 2015-11-11 16:02:14,665 DEBUG : BROWSER_OUTPUT: 16:02:15 INFO - 2015-11-11 16:02:15,577 INFO : Browser exited with error code: 0 16:02:15 INFO - 2015-11-11 16:02:15,631 INFO : Completed test kraken (00:01:01) 16:02:15 INFO - 2015-11-11 16:02:15,631 INFO : Starting test v8_7 16:02:15 INFO - 2015-11-11 16:02:15,631 DEBUG : operating with platform_type : linux_ 16:02:15 INFO - 2015-11-11 16:02:15,631 INFO : Initialising browser for v8_7 test... 16:02:15 INFO - 2015-11-11 16:02:15,637 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwfw8Y/profile http://localhost:55186/getInfo.html 16:02:20 INFO - 2015-11-11 16:02:20,124 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:02:20 INFO - 2015-11-11 16:02:20,125 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:02:20 INFO - 2015-11-11 16:02:20,125 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:02:20 INFO - 2015-11-11 16:02:20,125 DEBUG : BROWSER_OUTPUT: __metrics 16:02:21 INFO - 2015-11-11 16:02:21,217 INFO : Browser initialized. 16:02:21 INFO - 2015-11-11 16:02:21,217 INFO : Running cycle 1/1 for v8_7 test... 16:02:21 INFO - 2015-11-11 16:02:21,218 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNwfw8Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:02:33 INFO - 2015-11-11 16:02:33,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 139640832 16:02:33 INFO - 2015-11-11 16:02:33,128 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55186/tests/v8_7/run.html (next: http://localhost:55186/tests/v8_7/run.html) 16:02:54 INFO - 2015-11-11 16:02:54,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 138162176 16:02:54 INFO - 2015-11-11 16:02:54,884 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,885 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:02:54 INFO - 2015-11-11 16:02:54,885 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:02:54 INFO - 2015-11-11 16:02:54,885 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:02:54 INFO - 2015-11-11 16:02:54,885 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:02:54 INFO - 2015-11-11 16:02:54,886 DEBUG : BROWSER_OUTPUT: |0;Richards;162.86644951140065 16:02:54 INFO - 2015-11-11 16:02:54,886 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.9696048632219 16:02:54 INFO - 2015-11-11 16:02:54,886 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 16:02:54 INFO - 2015-11-11 16:02:54,886 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 16:02:54 INFO - 2015-11-11 16:02:54,887 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 16:02:54 INFO - 2015-11-11 16:02:54,887 DEBUG : BROWSER_OUTPUT: |5;Earley;729.3946024799417 16:02:54 INFO - 2015-11-11 16:02:54,887 DEBUG : BROWSER_OUTPUT: |6;Boyer;11811.764705882353 16:02:54 INFO - 2015-11-11 16:02:54,887 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 16:02:54 INFO - 2015-11-11 16:02:54,888 DEBUG : BROWSER_OUTPUT: |8;Splay;684.4626967830253 16:02:54 INFO - 2015-11-11 16:02:54,888 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 16:02:54 INFO - 2015-11-11 16:02:54,888 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:02:54 INFO - 2015-11-11 16:02:54,889 DEBUG : BROWSER_OUTPUT: __startTimestamp1447286574882__endTimestamp 16:02:54 INFO - 2015-11-11 16:02:54,889 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,889 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:02:54 INFO - 2015-11-11 16:02:54,890 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:02:54 INFO - 2015-11-11 16:02:54,890 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,890 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.87 Median:162.87 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,890 DEBUG : BROWSER_OUTPUT: Values: 162.9 16:02:54 INFO - 2015-11-11 16:02:54,891 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,891 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.97 Median:189.97 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,891 DEBUG : BROWSER_OUTPUT: Values: 190.0 16:02:54 INFO - 2015-11-11 16:02:54,891 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,892 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,892 DEBUG : BROWSER_OUTPUT: Values: 279.8 16:02:54 INFO - 2015-11-11 16:02:54,892 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,892 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,892 DEBUG : BROWSER_OUTPUT: Values: 5040.2 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: Values: 1060.4 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: Values: 729.4 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,893 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11811.76 Median:11811.76 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,894 DEBUG : BROWSER_OUTPUT: Values: 11811.8 16:02:54 INFO - 2015-11-11 16:02:54,894 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,894 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,895 DEBUG : BROWSER_OUTPUT: Values: 25897.4 16:02:54 INFO - 2015-11-11 16:02:54,895 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,895 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:684.46 Median:684.46 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,895 DEBUG : BROWSER_OUTPUT: Values: 684.5 16:02:54 INFO - 2015-11-11 16:02:54,895 DEBUG : BROWSER_OUTPUT: 16:02:54 INFO - 2015-11-11 16:02:54,896 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 16:02:54 INFO - 2015-11-11 16:02:54,896 DEBUG : BROWSER_OUTPUT: Values: 4822.1 16:02:54 INFO - 2015-11-11 16:02:54,896 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:02:54 INFO - 2015-11-11 16:02:54,896 DEBUG : BROWSER_OUTPUT: 16:02:55 INFO - 2015-11-11 16:02:55,829 INFO : Browser exited with error code: 0 16:02:55 INFO - 2015-11-11 16:02:55,844 INFO : Completed test v8_7 (00:00:40) 16:02:55 INFO - 2015-11-11 16:02:55,913 INFO : Completed test suite (00:20:15) 16:02:55 INFO - 2015-11-11 16:02:55,913 DEBUG : Working with test: dromaeo_css 16:02:55 INFO - 2015-11-11 16:02:55,913 DEBUG : Generating results file: dromaeo_css 16:02:55 INFO - 2015-11-11 16:02:55,914 DEBUG : Working with test: kraken 16:02:55 INFO - 2015-11-11 16:02:55,914 DEBUG : Generating results file: kraken 16:02:55 INFO - 2015-11-11 16:02:55,915 INFO : javascript benchmark 16:02:55 INFO - 2015-11-11 16:02:55,915 DEBUG : Working with test: v8_7 16:02:55 INFO - 2015-11-11 16:02:55,915 DEBUG : Generating results file: v8_7 16:02:55 INFO - 2015-11-11 16:02:55,915 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:55 INFO - 2015-11-11 16:02:55,966 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 16:02:55 INFO - 2015-11-11 16:02:55,966 DEBUG : process_Request line: dromaeo_css 5912.65 graph.html#tests=[[72,131,43]] 16:02:55 INFO - 2015-11-11 16:02:55,966 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:56 INFO - 2015-11-11 16:02:56,098 DEBUG : process_Request line: kraken 1552.90 graph.html#tests=[[232,131,43]] 16:02:56 INFO - 2015-11-11 16:02:56,099 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:02:56 INFO - 2015-11-11 16:02:56,128 DEBUG : process_Request line: v8_7 21194.51 graph.html#tests=[[230,131,43]] 16:02:56 INFO - 2015-11-11 16:02:56,130 INFO : javascript benchmark 16:02:56 INFO - 2015-11-11 16:02:56,133 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [338.3723193476102, 339.64507090090854, 339.7808413573245, 339.8691503771048, 342.32220203996087, 12429.192102513352, 12798.424070916808, 13039.152455090412, 15140.318685659144, 15215.46745863895, 14821.481248156317, 15158.85339950768, 16192.271347789349, 16408.26162822673, 16414.17929103546, 5014.648974571782, 5063.544281014708, 5206.193040078775, 5215.0, 5215.687058776467, 5018.071656743514, 5054.0, 5070.366204224472, 5092.541671249587, 5101.464346243628, 4548.385967894325, 4694.929576056362, 4695.17834378984, 5032.7735251913755, 5035.169197082477, 4638.0, 4641.071785642885, 4645.721256724591, 4658.9068218635775, 4671.719696818185, 3983.900402489961, 4143.274926887782, 4143.274926887782, 4144.834206631731, 4167.791610419497, 11754.177207595472, 12061.095417843697, 12140.757184856253, 12536.0, 12637.052221083455, 1712.7773389459414, 1729.1786401459206, 1746.772919520467, 1772.0342413384608, 1994.9426803794013, 8923.375363724477, 9080.954595227047, 9150.679726209617, 9200.0, 9321.813563728756, 1539.8383169767126, 1570.2384343593349, 1585.8969167004223, 1611.589044793582, 1616.0869108953405, 46994.29508557374, 47897.76051119722, 53078.20382694263, 53089.46910530884, 53225.7338713304, 6428.453581445536, 6635.137432133792, 6689.4982876284475, 6710.463162946952, 6748.561343512754, 7468.103827540621, 7569.697212111564, 7605.429592780563, 7765.262300081483, 7791.649375778104, 4693.436787585511, 4743.525647435229, 4792.520747925179, 4802.783874725646, 4824.445188803333, 4720.386349774507, 4746.169420351424, 4748.264019077049, 4760.64295177863, 4768.213244814567, 3030.848457577112, 3033.3326668132977, 3058.1895797613206, 3086.5678804967324, 3086.6758990306143, 1084.9945750271356, 1086.9565217391216, 1088.515610553312, 1089.05796486039, 1143.5597295041468, 421.3153625358792, 458.8921603423193, 463.40452518513547, 465.52748959805825, 477.3365022618563, 10332.276740628084, 10370.948145259226, 10474.68575942723, 10571.15430765537, 10584.682459526226, 428.9764062976504, 438.7367579452303, 439.9032212913154, 445.7860227091015, 455.40569556728127, 5584.944150558443, 5801.361850196475, 5862.736176872051, 5910.704464776744, 5932.762689492372, 484081.0, 486125.0, 487677.0, 487875.0, 492734.0, 65358.67320663366, 66036.66981665061, 66671.33328666652, 66991.0, 67822.3217767816, 507.34805774580224, 508.37469912008436, 510.04875906434233, 514.2902794144057, 514.4983640950119, 9603.231741460806, 9753.268504862306, 9806.166475849634, 9838.212942964688, 9845.458499782295, 29951.700482995762, 30040.09879703525, 33192.83403582966, 33226.169345766546, 33745.83127084349, 37788.43317350187, 38526.80736596299, 42768.572314277706, 43521.12957740891, 43596.34605480857, 5619.213310136666, 6127.877442451037, 6287.591306565058, 6329.050642403677, 6336.58812177207, 10805.675829725122, 11011.339319640847, 11012.559497620005, 11052.11583073336, 11146.665600031687, 2316.386157668253, 8454.957725211334, 9436.150746432853, 9913.801723965624, 10082.546285417027, 9337.325349301398, 9758.268129890144, 9852.310338276251, 9933.552990115317, 10141.847872281774, 9931.0, 9973.50132493387, 10102.646407375707, 10257.025582569644, 10265.897341026794, 5683.635927377482, 6209.472194863487, 6244.125822384961, 6257.342978987323, 6261.68691565429, 9778.511074446391, 9939.950300248742, 9963.452010139223, 10012.599496020077, 10023.849642255518], "dojo.html": [2643.088134593565, 2703.243091934259, 2711.8915243390265, 2731.0441345529066, 2749.0790585153973, 4614.123316569858, 4645.233536466488, 4721.12659158056, 4721.291806229063, 4737.431508219019, 4646.512116227798, 4678.415198100238, 4685.85942421727, 4766.5471780180915, 4781.952180478194, 4349.891252718684, 4369.169857727022, 4435.0, 4465.173942820572, 4475.507694153657, 4445.422095127629, 4458.866234012985, 4514.909701805962, 4517.593416592506, 4555.794989225493, 4162.084341444877, 4273.807678654437, 4283.186194623012, 4391.912161756747, 4397.692161548693, 4373.693841431101, 4374.125174964988, 4387.868363949086, 4410.669199810027, 4418.403515525395, 4207.43199668044, 4360.1279744051, 4373.431453911003, 4401.207782599131, 4408.030233348658, 4589.2886602576655, 4621.075784843045, 4733.976330118362, 4739.099571081518, 4763.499832517605, 5123.897522049576, 5154.381474223117, 5169.612279079084, 5171.663841850305, 5206.635535512516, 4918.311436398907, 5074.771635276385, 5195.350581177353, 5204.635675502716, 5211.739413029333, 4653.418322709661, 4706.811727530895, 4716.38686970695, 4744.7390393528685, 4769.902922327884, 5217.556507696812, 5226.425093239741, 5227.895442091137, 5236.6334356595435, 5291.391489978701, 4770.522947705202, 4997.425296090923, 5014.724190169502, 5031.119554078022, 5041.823536176216, 5026.170681837529, 5035.77339019745, 5080.54275115234, 5131.948680513147, 5177.818776342885, 5027.296178535008, 5063.063333283354, 5081.9745901271, 5117.692938423706, 5120.846374608767, 4852.102361063215, 4980.8754781130765, 5079.720615366116, 5089.389273287229, 5094.108531007059, 4162.167566486654, 4229.217594744982, 4229.577042295808, 4244.957550424456, 4246.4691913510815, 3712.7029837612927, 3730.757500762442, 3735.0662334416397, 3739.08392443853, 3759.774413535197, 4257.233697934402, 4290.420793192941, 4358.934615980763, 4447.555244475527, 4461.08547747711, 5165.405978312542, 5166.715830629351, 5180.533751962342, 5186.273921650972, 5212.55693266069, 4475.0, 4479.955200447954, 4486.846313769409, 4515.887102822456, 4524.8416305429155, 4354.259775838115, 4477.753723545236, 4490.820367185276, 4543.818247270138, 4619.95380046202, 4903.877403064952, 4917.434495033045, 4936.407631084149, 4942.184539551077, 4988.152014157529, 5191.558717509054, 5214.061468935628, 5214.165733482625, 5215.269862219368, 5218.0, 4720.881977950578, 4813.4945830687275, 4842.757862106951, 4875.268709693574, 4906.950930490792, 5048.318477005704, 5092.719900405513, 5094.337736094284, 5104.515071068243, 5138.152204886152, 4906.411230652345, 5157.819476318311, 5176.1200595898035, 5179.404368497671, 5185.144451165515, 4846.781894814812, 4874.0, 4888.60891128716, 4893.266010098514, 4901.3383193268455, 5027.849164524924, 5063.0, 5074.416442109205, 5079.136546787129, 5085.262636917701, 4964.528369804862, 4982.202847544376, 4989.501049894981, 4992.201247800334, 5008.774605142705, 4865.0756356292195, 4915.26271059344, 5009.924851127309, 5036.169032109808, 5099.847004589868, 4920.384951881015, 4924.852254432372, 4938.185199442052, 4959.380077490314, 4994.650374473752], "mootools.html": [1212.9757404851903, 1287.3820566128256, 1291.5415027665179, 1612.7661489084076, 1624.8456396642314, 6804.319568043194, 6866.759663411769, 6913.308669133085, 6928.237893831674, 6932.792016239515, 7098.254683258261, 7130.75042373517, 7140.678669459874, 7165.892511612317, 7209.567425954447, 2026.473116989586, 2033.5119571302855, 2036.3178335257705, 2048.72342233798, 2059.794020597943, 2053.3634573282256, 2075.968860467094, 2093.7173481579944, 2109.48317662173, 2113.7991890770354, 1998.5003749062735, 2065.163608738463, 2084.135083940163, 2084.9791502085013, 2088.2899814063217, 1982.1575830272077, 2018.0616013553622, 2018.3944816554974, 2018.656828339186, 2018.7476565429322, 2036.216056818121, 2115.270231770037, 2132.3070002249174, 2133.9466513337134, 2136.102836808544, 7083.822904427379, 7135.0, 7160.713571457136, 7160.785176444715, 7177.605231712254, 4096.139810639769, 4165.708400411972, 4172.269852775752, 4203.936940945889, 4211.178820130076, 2759.5446751286013, 2782.9721702783118, 2812.2125804774696, 2821.5767634854733, 2828.0950095969297, 904.4799240436776, 917.0462718772469, 921.7188757428981, 944.551338114397, 970.8252514547379, 9452.291078169164, 9545.713628591084, 9574.234061275081, 9589.520523973843, 9610.51947402627, 3732.1789206374556, 3801.4107813288983, 3818.3317919364, 3845.5193100862393, 3870.6129387061633, 7622.0, 7647.0, 7661.846763064707, 7667.616619169131, 7675.961620191863, 4174.5616710245595, 4181.456410666594, 4184.4141820145205, 4186.727862688916, 4210.90516465715, 3838.3666694995572, 3848.191879705237, 3851.326017946848, 3862.5558060822805, 3868.1876805871084, 3016.8189908605555, 3162.177833763238, 3168.3663267346624, 3176.729977951854, 3180.268538236219, 932.8414169591185, 934.8317302885546, 938.1884669760608, 941.0260380506144, 942.072059021863, 822.7696245051395, 827.995860020696, 828.5608627427473, 872.7207293665966, 956.5408603870043, 6330.68346582669, 6368.0, 6421.486281097501, 6436.485081193493, 6440.4847612190915, 1020.0921180149672, 1035.425338936882, 1047.9528421221064, 1050.1965996013057, 1053.7839742852698, 5158.0, 5204.713740744295, 5206.817761378409, 5213.817516386984, 5230.241614965808, 8152.714654987047, 8347.373946954003, 8452.366072544584, 8475.915240847513, 8598.355123365773, 8416.2004609562, 8446.957765211257, 8515.361347898932, 8527.0, 8634.740957771277, 6526.379993900572, 6663.5335526513645, 6666.0, 6727.9327206728285, 6767.018782276542, 6595.868082638416, 6648.0, 6671.39957403836, 6673.733050677918, 6674.666266686743, 7461.477696561188, 7644.426667999811, 7675.270849269311, 7682.385409167141, 7684.039495063117, 7644.36809619894, 7725.922740772745, 7746.728864489716, 7771.689132434639, 7775.300222979959, 6158.107074474266, 6162.7534898605345, 6221.502279817694, 6226.003839385677, 6237.376262373727, 6451.258105317761, 6502.8461196320695, 6508.284088750139, 6560.114384558215, 6567.113439685581, 6168.0439531872635, 6169.413905678954, 6280.434760871543, 6358.809235722936, 6384.680765961591, 5608.6073974823, 5779.219805326227, 6235.3452887446165, 6311.747530098744, 6391.936080639134, 6355.428011478989, 6359.872802544016, 6366.204224471941, 6383.39357761012, 6418.1656384669695, 5935.7032148391545, 5967.492763115184, 5968.194293770285, 5989.970050149721, 6007.098935159761, 5905.291365036223, 6020.458158765557, 6029.3669164737075, 6060.939390606214, 6065.4541091302], "ext.html": [542.6310109125794, 546.0, 556.9387367389586, 565.3187908570171, 570.0366380816423, 35780.64219357806, 36535.63464365362, 36541.451878221815, 36552.45171322432, 36610.0, 39101.21797564047, 39465.802670986675, 39527.80236098816, 39705.20589588206, 39848.20303593927, 7696.692132314714, 7980.241877021674, 7993.800154996143, 7995.520268783892, 8022.879656805123, 7784.961075194616, 7884.64519096642, 7894.921050789505, 7905.723299684512, 7932.841343173133, 7782.494137881048, 7793.532388056707, 7875.094364148111, 7892.131865494791, 7894.328982036505, 7773.494722843026, 7838.176991415876, 7845.254700803414, 7854.253845884689, 7884.881726774103, 7740.071191457061, 7825.569593672346, 7877.724279650185, 7883.645235964395, 7923.247291507298, 36248.81875590605, 36621.63378366236, 36685.0, 36793.08017299562, 36825.63174368276, 2634.2755742171057, 2650.2976711171555, 2692.17888543994, 2835.801493895428, 3081.4299354619466, 25688.486230275288, 25692.486150277076, 26054.218373448828, 26382.07662731795, 26742.866285668642, 2675.381698433294, 2738.0, 2741.629879966219, 2755.76575991041, 2757.131503576367, 215708.0, 217755.0, 218517.9999999984, 218788.0, 219231.0, 47498.52501474941, 48515.75742121267, 56218.0, 57234.42765572374, 57452.13821792677, 54155.0, 54161.45838541643, 54395.0, 54407.72796135994, 54420.0, 11677.824832627517, 11685.065194784396, 11786.233894796811, 11794.52821887115, 11812.527498899948, 8488.108748581433, 8519.062903080656, 8550.74347769568, 8567.614457349435, 8569.057403685589, 16787.83212167887, 17028.914855425643, 17092.0, 17119.74320385195, 17120.40078597243, 7040.823979400454, 7244.384227340735, 7269.454790890599, 7277.19950805411, 7310.488265821447, 826.0, 827.5696637748338, 835.6949713354581, 876.9342299327576, 877.863931090682, 22529.88735056314, 22777.658335124986, 22787.0, 22810.0, 22924.19765308206, 921.5115988526092, 935.0462528221312, 945.163530275711, 967.3325405470343, 1024.779672370444, 12458.75082498345, 12496.50013999448, 12556.686082848002, 13145.34273286351, 13610.455581776618, 262735.0, 263872.0, 264590.0, 265874.0, 266041.0, 41417.378739318934, 41417.79291103585, 41468.0, 41623.37564936528, 41681.79159104185, 1116.8715597706205, 1185.4013723069968, 1196.3898411809867, 1198.8261702053153, 1199.6700907250577, 25606.359841004123, 25895.870520647277, 26013.73986260113, 26106.73893261043, 26296.8685156573, 38397.42403864, 38468.6153138465, 38622.80688596539, 38744.41883371808, 38928.0, 244901.0, 248375.0, 248544.0, 248597.0, 248638.0, 23703.407414814767, 24453.51092978166, 24474.26577202687, 27390.45219095647, 27885.302867428476, 33595.83202083974, 34008.489872652426, 34243.31513369769, 34906.30187396289, 35058.298834022666, 29135.125946221648, 29164.0, 29347.119586412442, 29744.0, 30050.69949300479, 29126.27184320409, 29354.266143346587, 30556.388872222877, 31504.527432088078, 31745.20636984094, 30762.692373075985, 30946.53580196254, 31119.37761244717, 31326.37347253088, 31341.216469588442, 26978.730212698407, 28637.570436443886, 29086.0, 29716.55425168581, 29943.85028074846, 21031.684524731834, 23167.884160579088, 23821.642675359537, 24142.517149656556, 25449.236522904343], "prototype.html": [298.9402119576085, 304.66030376130624, 309.20996853040475, 309.7692219296623, 310.2631250779399, 5324.3610766708, 5379.058664733676, 5404.243405923174, 5442.8911421771545, 5471.808486702967, 5255.159174532076, 5293.258943747869, 5319.361676598804, 5333.093374126398, 5344.331958505187, 4020.7587544747407, 4105.2815757242515, 4107.7535347879075, 4115.156392939455, 4122.381642753596, 4088.1823635272917, 4089.5501494835544, 4112.485939257593, 4115.42384066231, 4115.54728979812, 4059.7158198926086, 4060.086480541869, 4063.918721625566, 4064.146529228851, 4069.2065047315637, 4050.351943689025, 4063.7358571692894, 4067.3085575452246, 4074.9592504074876, 4076.0421300994244, 3496.7552271341015, 3552.5381700379044, 3553.8045407502577, 3556.928861422757, 3585.354636165489, 5067.518585734386, 5097.515736005073, 5118.872028199287, 5154.768035438415, 5157.30376399185, 4627.028324051953, 4628.699134556243, 4631.258998560214, 4657.138429390539, 4658.510856360102, 5502.0371434999115, 5512.972435137799, 5518.227448157261, 5533.944660553383, 5537.0863807471715, 3793.696504279651, 3846.6538011578814, 3850.1144736710435, 3850.403187505941, 3854.0557563396865, 5669.546436285087, 5816.447437493432, 5900.380460051676, 5902.468777810018, 5906.5570082244, 4024.678025757932, 4024.71826972115, 4025.4364388985564, 4027.134166154291, 4027.7180597357906, 4084.81618327176, 4093.16090201508, 4094.836206551764, 4099.0162361033135, 4100.036491424513, 4669.976650116728, 4676.485586585472, 4678.789454474557, 4679.99380133273, 4680.391549098664, 5406.459354064562, 5441.510264076173, 5505.229267902497, 5514.834554963358, 5515.641483303652, 1421.7654087075723, 1443.444273954514, 1444.2706433251142, 1444.3283872999107, 1444.9422023118957, 970.9902900971041, 984.2962281968427, 994.6469003503797, 1002.659095907395, 1007.1338648762058, 4891.559759621651, 4897.0, 4899.608031357554, 4905.583025442877, 4973.079980203674, 5834.154047663065, 5834.766609335664, 5836.358000619928, 5849.298084229919, 5854.121881717691, 4960.181570040902, 4963.329950456714, 4966.453690094087, 4966.826161084345, 4969.229769385751, 3162.304293055524, 3197.7921435106646, 3219.742420606346, 3225.1130938991496, 3229.5963004624423, 5490.972545137249, 5491.945080549223, 5494.752736126884, 5494.945050549523, 5501.312335958005, 5968.194293770285, 5972.402759723993, 5973.253343332083, 5973.850653733692, 5986.640801551921, 5476.096444086681, 5484.561235101182, 5487.6981766003255, 5491.121420572689, 5496.258005169331, 5639.971800140973, 5852.414758524284, 5889.116632505158, 5896.027155519291, 5903.173555702119, 5704.914426283692, 5718.485336319751, 5720.713964301852, 5757.481826635623, 5785.508231800344, 5549.0, 5551.528120109836, 5574.581906356958, 5576.0, 5581.0, 3964.861229856941, 3984.900377490586, 4048.3117869962766, 4063.471748672772, 4066.390041493681, 5734.3978882218435, 5807.883842323045, 5909.527237820878, 5910.231669882888, 5911.290645122613, 5567.944320556742, 5571.721413929368, 5578.748956297058, 5604.8318550443555, 5616.775328986795, 5574.832755017356, 5578.721063946868, 5594.776208951759, 5598.972005139948, 5613.24221230145, 5369.140937449989, 5488.204210389391, 5492.395836458067, 5497.3952865184, 5509.0, 5621.80323688669, 5684.602077854511, 5698.971505142447, 5712.057510510719, 5714.628549144292, 5545.334559852843, 5553.666779993213, 5555.583331250092, 5557.277553917965, 5559.63862348946], "yui.html": [603.5382932056975, 707.8831992721201, 760.6120878352042, 763.725058978768, 765.877459606463, 10448.425336606484, 10611.469426528662, 10619.044286014258, 10703.83944240836, 10727.302725322857, 11679.0, 11758.647240582775, 11781.057515398768, 11784.587539436121, 11877.940610296937, 596.9641821490703, 602.1479606357, 726.5422783646309, 735.5549892315153, 747.4020783373306, 741.4550305525435, 745.7427187620262, 750.0399488654504, 751.0761763031475, 751.8233215194425, 791.5923299500762, 795.5425630262594, 797.2784629909941, 797.6849144587884, 800.5596921693075, 788.1527358090048, 788.1999770233218, 788.4953629677011, 788.5505262000662, 790.1308560583399, 570.1220121013635, 576.6655339902846, 577.9797707080274, 578.6441338576788, 580.8344621782813, 11233.32600044, 11352.148588855785, 11353.943230283796, 11365.602203922823, 11374.203805733601, 8927.598258078402, 8957.238634715992, 9052.8642070369, 9297.442153470813, 9340.20608248293, 8863.335249856222, 8920.821583568293, 8995.370324077317, 9023.323250756153, 9185.081491850828, 2779.4580056888913, 2800.6079148919166, 2804.5092108880863, 2807.466581349537, 2821.2664707176077, 39862.402063969064, 40297.79851100755, 40389.19221615551, 40443.39334909979, 40445.595544044474, 6696.363845434774, 6701.229358623723, 6786.524943254023, 6842.178938527409, 6944.583325000516, 10260.127889129359, 10272.0, 10277.94861025705, 10292.176625869912, 10313.48432578368, 5398.4871437213405, 5414.242006119146, 5578.0, 5654.717264136777, 5799.33307669615, 3504.141485336109, 3515.33208690348, 3532.947005794915, 3558.5018097466377, 3621.8913432597064, 2472.9010839566577, 2488.4525404411, 2488.4525404411, 2511.54792137417, 2515.7861581765387, 388.793939212218, 391.0829105747019, 393.3215203773525, 397.37810326838405, 397.97015223858324, 446.5422941485004, 466.55444050931277, 471.9362886010413, 528.4319356691495, 559.2589818490517, 7790.454668173174, 7894.723684671009, 7961.960190199012, 8035.879461808077, 8041.236082572146, 423.4368290174061, 467.8081986385566, 478.56928764112575, 481.65320968902336, 510.50226029621564, 3644.4168932970597, 3655.8354874030733, 3823.388257878726, 3914.9608503914596, 3933.2330195612153, 49455.25817112746, 50167.0, 50359.49640503621, 51164.23253651198, 51523.48476515262, 42190.57809421928, 42339.15321693549, 43395.56604433915, 43489.347659785126, 43523.78238108789, 42238.15523689509, 42448.0, 42728.35907461391, 42931.35602965958, 43168.78415607902, 8031.357491400557, 8338.499690018618, 8522.957385213034, 8572.571371431279, 8621.82756344857, 30077.248068798453, 30175.245618859703, 30415.847920760254, 30544.694553054185, 30563.847180763954, 38748.6125138745, 39185.49366822738, 39671.00822479461, 39965.0, 40084.59915400809, 6980.895286570807, 6990.825229369103, 7155.3202445767565, 7246.5289756165685, 7460.776176714708, 11326.433678316216, 11333.376664283544, 11346.773064538827, 11598.478068487108, 11627.418629068681, 10772.773032184868, 10888.0, 10937.671869843918, 10997.780044399227, 11054.944725276322, 10107.69676909694, 10142.137918276734, 10251.179905607683, 10323.32898361604, 10615.946920265349, 10619.893801062199, 10686.198535110054, 10730.087942524973, 10896.12830973536, 10951.123910087015, 9043.140901614335, 9071.923567258333, 9260.166585007382, 9456.2907781918, 9457.148856602938, 8890.777730556787, 9043.773905652148, 9119.361644684808, 9216.151076639164, 9228.40015398997]}, "summary": {"lowerIsBetter": false, "suite": 5912.654314139657, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6383.64795155761, "unit": "ms", "value": 6383.64795155761}, "dojo.html": {"lowerIsBetter": false, "filtered": 4686.78034170609, "unit": "ms", "value": 4686.78034170609}, "mootools.html": {"lowerIsBetter": false, "filtered": 4012.2684043854792, "unit": "ms", "value": 4012.2684043854792}, "ext.html": {"lowerIsBetter": false, "filtered": 15896.276941021024, "unit": "ms", "value": 15896.276941021024}, "prototype.html": {"lowerIsBetter": false, "filtered": 4211.224025683588, "unit": "ms", "value": 4211.224025683588}, "yui.html": {"lowerIsBetter": false, "filtered": 5316.395801878524, "unit": "ms", "value": 5316.395801878524}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-046.e"}, "testrun": {"date": 1447285360, "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": "20151111143931", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}, {"talos_counters": {}, "results": {"audio-dft": [169.0, 172.0, 165.0, 165.0, 166.0, 170.0, 167.0, 164.0, 165.0, 164.0], "ai-astar": [116.0, 108.0, 118.0, 110.0, 113.0, 124.0, 112.0, 113.0, 113.0, 114.0], "imaging-gaussian-blur": [111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 112.0, 110.0, 111.0, 111.0], "audio-beat-detection": [158.0, 131.0, 164.0, 174.0, 131.0, 158.0, 166.0, 135.0, 163.0, 131.0], "json-stringify-tinderbox": [66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [136.0, 146.0, 150.0, 145.0, 147.0, 153.0, 147.0, 145.0, 151.0, 149.0], "json-parse-financial": [72.0, 72.0, 73.0, 72.0, 75.0, 72.0, 75.0, 72.0, 73.0, 74.0], "stanford-crypto-sha256-iterative": [70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 70.0, 71.0, 68.0, 71.0], "audio-fft": [75.0, 74.0, 74.0, 74.0, 150.0, 72.0, 73.0, 73.0, 74.0, 161.0], "imaging-darkroom": [147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 150.0, 148.0], "stanford-crypto-ccm": [132.0, 121.0, 126.0, 125.0, 135.0, 123.0, 129.0, 133.0, 125.0, 129.0], "audio-oscillator": [93.0, 91.0, 136.0, 92.0, 91.0, 92.0, 137.0, 93.0, 92.0, 129.0], "stanford-crypto-aes": [83.0, 85.0, 84.0, 83.0, 84.0, 83.0, 84.0, 87.0, 98.0, 97.0], "imaging-desaturate": [96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1552.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 90.0, "unit": "ms", "value": 90.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.1, "unit": "ms", "value": 151.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 127.8, "unit": "ms", "value": 127.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.3, "unit": "ms", "value": 148.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.0, "unit": "ms", "value": 73.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 114.1, "unit": "ms", "value": 114.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 166.7, "unit": "ms", "value": 166.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-046.e"}, "testrun": {"date": 1447285360, "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": "20151111143931", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}, {"talos_counters": {}, "results": {"DeltaBlue": [189.9696048632219], "Encrypt": [279.79854504756577], "NavierStokes": [4822.115384615385], "Decrypt": [5040.201005025126], "Splay": [684.4626967830253], "Richards": [162.86644951140065], "RegExp": [25897.4358974359], "Earley": [729.3946024799417], "Boyer": [11811.764705882353], "RayTrace": [1060.4453870625662]}, "summary": {"lowerIsBetter": false, "suite": 21194.50833972996, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 348.04515199999986, "unit": "score", "value": 348.04515199999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 951.330894, "unit": "score", "value": 951.330894}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 119.05835100000004, "unit": "score", "value": 119.05835100000004}, "RegExp": {"lowerIsBetter": false, "filtered": 35.17664851485149, "unit": "score", "value": 35.17664851485149}, "Richards": {"lowerIsBetter": false, "filtered": 216.75427999999994, "unit": "score", "value": 216.75427999999994}, "Earley": {"lowerIsBetter": false, "filtered": 913.7207730000002, "unit": "score", "value": 913.7207730000002}, "Boyer": {"lowerIsBetter": false, "filtered": 56.42366035856573, "unit": "score", "value": 56.42366035856573}, "RayTrace": {"lowerIsBetter": false, "filtered": 697.809627, "unit": "score", "value": 697.809627}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-046.e"}, "testrun": {"date": 1447285360, "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": "20151111143931", "branch": "Mozilla-Inbound-Non-PGO", "revision": "c5780f2a10e8de3171e12f080d99f62a0c6ca1a5"}}] 16:02:56 INFO - RETURN: dromaeo_css: 5912.65 16:02:56 INFO - RETURN: kraken: 1552.90 16:02:56 INFO - RETURN: v8_7: 21194.51 16:02:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21194.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1552.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "5912.65"}}} 16:02:56 INFO - Return code: 0 16:02:56 INFO - # TBPL SUCCESS # 16:02:56 INFO - Running post-action listener: _resource_record_post_action 16:02:56 INFO - Running post-run listener: _resource_record_post_run 16:02:57 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515440640; Read time: 168; Write time: 434600 16:02:57 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 176136192; Read time: 0; Write time: 186912 16:02:57 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 300507136; Read time: 0; Write time: 234688 16:02:57 INFO - Running post-run listener: _upload_blobber_files 16:02:57 INFO - Blob upload gear active. 16:02:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:02:57 INFO - Copying logs to upload dir... 16:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.690951 ========= master_lag: 59.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-11 16:03:56.288247) ========= ========= Started set props: build_url (results: 0, elapsed: 24 secs) (at 2015-11-11 16:03:56.291451) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010109 build_url: 'https://queue.taskcluster.net/v1/task/-r_VYqP8SruAH9XFKFGKlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 24.78 ========= ========= Finished set props: build_url (results: 0, elapsed: 24 secs) (at 2015-11-11 16:04:21.081982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:04:21.082318) ========= 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=fce1c2174958ee92775f70ae000001a3-1447284755.738277-1748861283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 16:04:21.106998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 16:04:21.110345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 16:04:21.112472) ========= ========= Total master_lag: 84.26 =========