builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1447431828.52 results: success (0) buildid: 20151113072730 builduid: 9714227fb40e48d6ba79cf124e1e44f6 revision: 97e1e855ec9ae5776ce04919f0da1d650d4f410f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:48.516940) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:48.517993) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-13 08:23:48.518666) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006509 basedir: '/builds/slave/test' ========= master_lag: 2.26 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-13 08:23:50.780259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.780638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.794875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.795211) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.845619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.845995) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.846484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:50.846859) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 08:23:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-11-13 08:23:51 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:51.067978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:51.068563) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015804 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:51.120246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-13 08:23:51.120678) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 97e1e855ec9ae5776ce04919f0da1d650d4f410f --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 97e1e855ec9ae5776ce04919f0da1d650d4f410f --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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 08:23:51,490 truncating revision to first 12 chars 2015-11-13 08:23:51,490 Setting DEBUG logging. 2015-11-13 08:23:51,490 attempt 1/10 2015-11-13 08:23:51,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/97e1e855ec9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 08:23:52,531 unpacking tar archive at: mozilla-inbound-97e1e855ec9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306327 ========= master_lag: 1.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-13 08:23:54.279095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:54.279524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:54.480736) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:54.481292) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 08:23:54.483099) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-13 08:23:54.483554) ========= /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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:54 INFO - MultiFileLogger online at 20151113 08:23:54 in /builds/slave/test 08:23:54 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 08:23:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:54 INFO - {'append_to_log': False, 08:23:54 INFO - 'base_work_dir': '/builds/slave/test', 08:23:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:23:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:54 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:23:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:54 INFO - 'config_files': ('talos/linux_config.py',), 08:23:54 INFO - 'default_actions': ('clobber', 08:23:54 INFO - 'read-buildbot-config', 08:23:54 INFO - 'download-and-extract', 08:23:54 INFO - 'populate-webroot', 08:23:54 INFO - 'create-virtualenv', 08:23:54 INFO - 'install', 08:23:54 INFO - 'run-tests'), 08:23:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:54 INFO - 'download_minidump_stackwalk': True, 08:23:54 INFO - 'download_symbols': 'ondemand', 08:23:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:54 INFO - 'installer_path': 'installer.exe', 08:23:54 INFO - 'log_level': 'info', 08:23:54 INFO - 'log_name': 'talos', 08:23:54 INFO - 'log_to_console': True, 08:23:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:54 INFO - 'opt_config_files': (), 08:23:54 INFO - 'pip_index': False, 08:23:54 INFO - 'sps_profile': False, 08:23:54 INFO - 'sps_profile_interval': 0, 08:23:54 INFO - 'suite': 'dromaeojs-e10s', 08:23:54 INFO - 'system_bits': '64', 08:23:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:54 INFO - 'title': 'talos-linux64-ix-038', 08:23:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:54 INFO - 'use_talos_json': True, 08:23:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:54 INFO - 'work_dir': 'build'} 08:23:54 INFO - ##### 08:23:54 INFO - ##### Running clobber step. 08:23:54 INFO - ##### 08:23:54 INFO - Running pre-action listener: _resource_record_pre_action 08:23:54 INFO - Running main action method: clobber 08:23:54 INFO - rmtree: /builds/slave/test/build 08:23:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:55 INFO - Running post-action listener: _resource_record_post_action 08:23:55 INFO - ##### 08:23:55 INFO - ##### Running read-buildbot-config step. 08:23:55 INFO - ##### 08:23:55 INFO - Running pre-action listener: _resource_record_pre_action 08:23:55 INFO - Running main action method: read_buildbot_config 08:23:55 INFO - Using buildbot properties: 08:23:55 INFO - { 08:23:55 INFO - "properties": { 08:23:55 INFO - "buildnumber": 2580, 08:23:55 INFO - "product": "firefox", 08:23:55 INFO - "script_repo_revision": "production", 08:23:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:23:55 INFO - "repository": "", 08:23:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 08:23:55 INFO - "buildid": "20151113072730", 08:23:55 INFO - "slavename": "talos-linux64-ix-038", 08:23:55 INFO - "pgo_build": "False", 08:23:55 INFO - "basedir": "/builds/slave/test", 08:23:55 INFO - "project": "", 08:23:55 INFO - "platform": "ubuntu64_hw", 08:23:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:55 INFO - "slavebuilddir": "test", 08:23:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 08:23:55 INFO - "branch": "mozilla-inbound", 08:23:55 INFO - "repo_path": "integration/mozilla-inbound", 08:23:55 INFO - "stage_platform": "linux64", 08:23:55 INFO - "builduid": "9714227fb40e48d6ba79cf124e1e44f6", 08:23:55 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:23:55 INFO - }, 08:23:55 INFO - "sourcestamp": { 08:23:55 INFO - "repository": "", 08:23:55 INFO - "hasPatch": false, 08:23:55 INFO - "project": "", 08:23:55 INFO - "branch": "mozilla-inbound-linux64-talos", 08:23:55 INFO - "changes": [ 08:23:55 INFO - { 08:23:55 INFO - "category": null, 08:23:55 INFO - "files": [ 08:23:55 INFO - { 08:23:55 INFO - "url": null, 08:23:55 INFO - "name": "https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:23:55 INFO - } 08:23:55 INFO - ], 08:23:55 INFO - "repository": "", 08:23:55 INFO - "rev": "97e1e855ec9ae5776ce04919f0da1d650d4f410f", 08:23:55 INFO - "who": "philip.chee@gmail.com", 08:23:55 INFO - "when": 1447431208, 08:23:55 INFO - "number": 6658911, 08:23:55 INFO - "comments": "Merge Bug 1204338 Followup to Bug 403800 Refactor netError.dtd/netErrorApp.dtd to simplify per-application overrides r=Pike", 08:23:55 INFO - "project": "", 08:23:55 INFO - "at": "Fri 13 Nov 2015 08:13:28", 08:23:55 INFO - "branch": "mozilla-inbound-linux64-talos", 08:23:55 INFO - "revlink": "", 08:23:55 INFO - "properties": [ 08:23:55 INFO - [ 08:23:55 INFO - "buildid", 08:23:55 INFO - "20151113072730", 08:23:55 INFO - "Change" 08:23:55 INFO - ], 08:23:55 INFO - [ 08:23:55 INFO - "builduid", 08:23:55 INFO - "9714227fb40e48d6ba79cf124e1e44f6", 08:23:55 INFO - "Change" 08:23:55 INFO - ], 08:23:55 INFO - [ 08:23:55 INFO - "pgo_build", 08:23:55 INFO - "False", 08:23:55 INFO - "Change" 08:23:55 INFO - ] 08:23:55 INFO - ], 08:23:55 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:23:55 INFO - } 08:23:55 INFO - ], 08:23:55 INFO - "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f" 08:23:55 INFO - } 08:23:55 INFO - } 08:23:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:23:55 INFO - Running post-action listener: _resource_record_post_action 08:23:55 INFO - ##### 08:23:55 INFO - ##### Running download-and-extract step. 08:23:55 INFO - ##### 08:23:55 INFO - Running pre-action listener: _resource_record_pre_action 08:23:55 INFO - Running main action method: download_and_extract 08:23:55 INFO - mkdir: /builds/slave/test/build/tests 08:23:55 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')]} 08:23:55 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json 08:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json 08:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:23:56 INFO - Downloaded 1302 bytes. 08:23:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:23:56 INFO - Using the following test package requirements: 08:23:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'jsshell-linux-x86_64.zip'], 08:23:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23: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')]} 08:23:56 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:23:57 INFO - Downloaded 21256903 bytes. 08:23:57 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 08:23:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:57 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 08:23:58 INFO - Return code: 0 08:23:58 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 08:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:58 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:23:59 INFO - Downloaded 21256903 bytes. 08:23:59 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 08:23:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:23:59 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 08:24:00 INFO - Return code: 0 08:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:00 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:24:01 INFO - Downloaded 11131693 bytes. 08:24:01 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 08:24:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:01 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 08:24:01 INFO - Return code: 0 08:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:01 INFO - https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wqaN_13ESnelH8GXU4RiEw/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 08:24:03 INFO - Downloaded 55625122 bytes. 08:24:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:03 INFO - mkdir: /builds/slave/test/properties 08:24:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:03 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:03 INFO - Contents: 08:24:03 INFO - build_url:https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:03 INFO - Running post-action listener: _resource_record_post_action 08:24:03 INFO - Running post-action listener: set_extra_try_arguments 08:24:03 INFO - ##### 08:24:03 INFO - ##### Running populate-webroot step. 08:24:03 INFO - ##### 08:24:03 INFO - Running pre-action listener: _resource_record_pre_action 08:24:03 INFO - Running main action method: populate_webroot 08:24:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:24:03 INFO - '../fennec_ids.txt'], 08:24:03 INFO - 'tests': ['tcheck2']}, 08:24:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:03 INFO - '--tppagecycles', 08:24:03 INFO - '7'], 08:24:03 INFO - 'tests': ['tsvgm']}}, 08:24:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:24:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['damp', 'tps']}, 08:24:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['damp', 'tps']}, 08:24:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:24:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:03 INFO - 'other': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other_l64': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other_nol64': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'svgr': {'tests': ['tsvgx', 08:24:03 INFO - 'tsvgr_opacity', 08:24:03 INFO - 'tart', 08:24:03 INFO - 'tscrollx', 08:24:03 INFO - 'cart']}, 08:24:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tsvgx', 08:24:03 INFO - 'tsvgr_opacity', 08:24:03 INFO - 'tart', 08:24:03 INFO - 'tscrollx', 08:24:03 INFO - 'cart']}, 08:24:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['tp5o']}, 08:24:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tp5o']}, 08:24:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--xperf_path', 08:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:03 INFO - 'tests': ['tp5n']}, 08:24:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s', 08:24:03 INFO - '--xperf_path', 08:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:03 INFO - 'tests': ['tp5n']}}, 08:24:03 INFO - 'talos.zip': {'path': '', 08:24:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:03 INFO - Running post-action listener: _resource_record_post_action 08:24:03 INFO - ##### 08:24:03 INFO - ##### Running create-virtualenv step. 08:24:03 INFO - ##### 08:24:03 INFO - Running pre-action listener: _resource_record_pre_action 08:24:03 INFO - Running main action method: create_virtualenv 08:24:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:03 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 08:24:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:03 INFO - Using real prefix '/usr' 08:24:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:05 INFO - Installing pip.................done. 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:05 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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'DISPLAY': ':0', 08:24:05 INFO - 'HOME': '/home/cltbld', 08:24:05 INFO - 'LANG': 'en_US.UTF-8', 08:24:05 INFO - 'LANGUAGE': 'en_US:en', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MAIL': '/var/mail/cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SHLVL': '1', 08:24:05 INFO - 'TERM': 'linux', 08:24:05 INFO - 'TMOUT': '86400', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - '_': '/tools/buildbot/bin/python'} 08:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:06 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 08:24:06 INFO - Cleaning up... 08:24:06 INFO - Return code: 0 08:24:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:06 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:06 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 08:24:06 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 08:24:06 INFO - Using env: {'DISPLAY': ':0', 08:24:06 INFO - 'HOME': '/home/cltbld', 08:24:06 INFO - 'LANG': 'en_US.UTF-8', 08:24:06 INFO - 'LANGUAGE': 'en_US:en', 08:24:06 INFO - 'LOGNAME': 'cltbld', 08:24:06 INFO - 'MAIL': '/var/mail/cltbld', 08:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:06 INFO - 'MOZ_NO_REMOTE': '1', 08:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:06 INFO - 'NO_EM_RESTART': '1', 08:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:06 INFO - 'PWD': '/builds/slave/test', 08:24:06 INFO - 'SHELL': '/bin/bash', 08:24:06 INFO - 'SHLVL': '1', 08:24:06 INFO - 'TERM': 'linux', 08:24:06 INFO - 'TMOUT': '86400', 08:24:06 INFO - 'USER': 'cltbld', 08:24:06 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:06 INFO - '_': '/tools/buildbot/bin/python'} 08:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:06 INFO - Downloading/unpacking psutil>=0.7.1 08:24:06 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 08:24:06 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 08:24:06 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 08:24:06 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 08:24:06 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 08:24:06 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 08:24:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:08 INFO - Installing collected packages: psutil 08:24:08 INFO - Running setup.py install for psutil 08:24:08 INFO - building 'psutil._psutil_linux' extension 08:24:08 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 08:24:08 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 08:24:08 INFO - building 'psutil._psutil_posix' extension 08:24:08 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 08:24:08 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 08:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:08 INFO - Successfully installed psutil 08:24:08 INFO - Cleaning up... 08:24:08 INFO - Return code: 0 08:24:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:24:08 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')]} 08:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:08 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')]} 08:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:08 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:08 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 08:24:08 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 08:24:08 INFO - Using env: {'DISPLAY': ':0', 08:24:08 INFO - 'HOME': '/home/cltbld', 08:24:08 INFO - 'LANG': 'en_US.UTF-8', 08:24:08 INFO - 'LANGUAGE': 'en_US:en', 08:24:08 INFO - 'LOGNAME': 'cltbld', 08:24:08 INFO - 'MAIL': '/var/mail/cltbld', 08:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:08 INFO - 'MOZ_NO_REMOTE': '1', 08:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:08 INFO - 'NO_EM_RESTART': '1', 08:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:08 INFO - 'PWD': '/builds/slave/test', 08:24:08 INFO - 'SHELL': '/bin/bash', 08:24:08 INFO - 'SHLVL': '1', 08:24:08 INFO - 'TERM': 'linux', 08:24:08 INFO - 'TMOUT': '86400', 08:24:08 INFO - 'USER': 'cltbld', 08:24:08 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:08 INFO - '_': '/tools/buildbot/bin/python'} 08:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:24:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:24:10 INFO - Installing collected packages: mozsystemmonitor 08:24:10 INFO - Running setup.py install for mozsystemmonitor 08:24:10 INFO - Successfully installed mozsystemmonitor 08:24:10 INFO - Cleaning up... 08:24:10 INFO - Return code: 0 08:24:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24:10 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')]} 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 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')]} 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:10 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 08:24:10 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 08:24:10 INFO - Using env: {'DISPLAY': ':0', 08:24:10 INFO - 'HOME': '/home/cltbld', 08:24:10 INFO - 'LANG': 'en_US.UTF-8', 08:24:10 INFO - 'LANGUAGE': 'en_US:en', 08:24:10 INFO - 'LOGNAME': 'cltbld', 08:24:10 INFO - 'MAIL': '/var/mail/cltbld', 08:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:10 INFO - 'MOZ_NO_REMOTE': '1', 08:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:10 INFO - 'NO_EM_RESTART': '1', 08:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:10 INFO - 'PWD': '/builds/slave/test', 08:24:10 INFO - 'SHELL': '/bin/bash', 08:24:10 INFO - 'SHLVL': '1', 08:24:10 INFO - 'TERM': 'linux', 08:24:10 INFO - 'TMOUT': '86400', 08:24:10 INFO - 'USER': 'cltbld', 08:24:10 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:10 INFO - '_': '/tools/buildbot/bin/python'} 08:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:13 INFO - Downloading docopt-0.6.1.tar.gz 08:24:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:13 INFO - Running setup.py install for blobuploader 08:24:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:13 INFO - Running setup.py install for requests 08:24:13 INFO - Running setup.py install for docopt 08:24:13 INFO - Successfully installed blobuploader requests docopt 08:24:13 INFO - Cleaning up... 08:24:13 INFO - Return code: 0 08:24:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:13 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:13 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 08:24:13 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 08:24:13 INFO - Using env: {'DISPLAY': ':0', 08:24:13 INFO - 'HOME': '/home/cltbld', 08:24:13 INFO - 'LANG': 'en_US.UTF-8', 08:24:13 INFO - 'LANGUAGE': 'en_US:en', 08:24:13 INFO - 'LOGNAME': 'cltbld', 08:24:13 INFO - 'MAIL': '/var/mail/cltbld', 08:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:13 INFO - 'MOZ_NO_REMOTE': '1', 08:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:13 INFO - 'NO_EM_RESTART': '1', 08:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:13 INFO - 'PWD': '/builds/slave/test', 08:24:13 INFO - 'SHELL': '/bin/bash', 08:24:13 INFO - 'SHLVL': '1', 08:24:13 INFO - 'TERM': 'linux', 08:24:13 INFO - 'TMOUT': '86400', 08:24:13 INFO - 'USER': 'cltbld', 08:24:13 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:13 INFO - '_': '/tools/buildbot/bin/python'} 08:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:14 INFO - Running setup.py (path:/tmp/pip-7YZp1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:14 INFO - Running setup.py (path:/tmp/pip-iienxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:14 INFO - Running setup.py (path:/tmp/pip-aOspU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:14 INFO - Running setup.py (path:/tmp/pip-ZxcSQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:14 INFO - Running setup.py (path:/tmp/pip-Ej0J2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:14 INFO - Running setup.py (path:/tmp/pip-58QTE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:14 INFO - Running setup.py (path:/tmp/pip-FFaeZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:14 INFO - Running setup.py (path:/tmp/pip-FT52gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:14 INFO - Running setup.py (path:/tmp/pip-ltcG0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:14 INFO - Running setup.py (path:/tmp/pip-1lVS3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:14 INFO - Running setup.py (path:/tmp/pip-VUczjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:14 INFO - Running setup.py (path:/tmp/pip-u0UN_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:14 INFO - Running setup.py (path:/tmp/pip-AmrzGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:15 INFO - Running setup.py (path:/tmp/pip-wnxEZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:15 INFO - Running setup.py (path:/tmp/pip-cgcMdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:15 INFO - Running setup.py (path:/tmp/pip-f7aVMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:15 INFO - Running setup.py (path:/tmp/pip-Hi2Ic7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:15 INFO - Running setup.py install for manifestparser 08:24:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Running setup.py install for mozcrash 08:24:15 INFO - Running setup.py install for mozdebug 08:24:15 INFO - Running setup.py install for mozdevice 08:24:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Running setup.py install for mozfile 08:24:15 INFO - Running setup.py install for mozhttpd 08:24:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Running setup.py install for mozinfo 08:24:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Running setup.py install for mozInstall 08:24:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Running setup.py install for mozleak 08:24:16 INFO - Running setup.py install for mozlog 08:24:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Running setup.py install for moznetwork 08:24:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Running setup.py install for mozprocess 08:24:16 INFO - Running setup.py install for mozprofile 08:24:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Running setup.py install for mozrunner 08:24:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:16 INFO - Running setup.py install for mozscreenshot 08:24:16 INFO - Running setup.py install for moztest 08:24:16 INFO - Running setup.py install for mozversion 08:24:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:17 INFO - Cleaning up... 08:24:17 INFO - Return code: 0 08:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:17 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:17 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 08:24:17 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 08:24:17 INFO - Using env: {'DISPLAY': ':0', 08:24:17 INFO - 'HOME': '/home/cltbld', 08:24:17 INFO - 'LANG': 'en_US.UTF-8', 08:24:17 INFO - 'LANGUAGE': 'en_US:en', 08:24:17 INFO - 'LOGNAME': 'cltbld', 08:24:17 INFO - 'MAIL': '/var/mail/cltbld', 08:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:17 INFO - 'MOZ_NO_REMOTE': '1', 08:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:17 INFO - 'NO_EM_RESTART': '1', 08:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:17 INFO - 'PWD': '/builds/slave/test', 08:24:17 INFO - 'SHELL': '/bin/bash', 08:24:17 INFO - 'SHLVL': '1', 08:24:17 INFO - 'TERM': 'linux', 08:24:17 INFO - 'TMOUT': '86400', 08:24:17 INFO - 'USER': 'cltbld', 08:24:17 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:17 INFO - '_': '/tools/buildbot/bin/python'} 08:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:17 INFO - Running setup.py (path:/tmp/pip-lVW1Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:17 INFO - Running setup.py (path:/tmp/pip-ja_BAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:17 INFO - Running setup.py (path:/tmp/pip-A4ZJdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:17 INFO - Running setup.py (path:/tmp/pip-ggBAdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:17 INFO - Running setup.py (path:/tmp/pip-ErSeEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:17 INFO - Running setup.py (path:/tmp/pip-cNA1px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:17 INFO - Running setup.py (path:/tmp/pip-nHFW_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:17 INFO - Running setup.py (path:/tmp/pip-5LP8Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:17 INFO - Running setup.py (path:/tmp/pip-pgk6Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:17 INFO - Running setup.py (path:/tmp/pip-q2LTB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:18 INFO - Running setup.py (path:/tmp/pip-edczxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:18 INFO - Running setup.py (path:/tmp/pip-IE2exk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:18 INFO - Running setup.py (path:/tmp/pip-_x8xHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:18 INFO - Running setup.py (path:/tmp/pip-z36s09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:18 INFO - Running setup.py (path:/tmp/pip-94fBNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:18 INFO - Running setup.py (path:/tmp/pip-YWNWY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:18 INFO - Running setup.py (path:/tmp/pip-faeK25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24: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 08:24: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 08:24: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 08:24: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 08:24: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 08:24: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 08:24:20 INFO - Downloading blessings-1.5.1.tar.gz 08:24:20 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 08:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:20 INFO - Installing collected packages: blessings 08:24:20 INFO - Running setup.py install for blessings 08:24:20 INFO - Successfully installed blessings 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:20 INFO - Reading from file tmpfile_stdout 08:24:20 INFO - Current package versions: 08:24:20 INFO - argparse == 1.2.1 08:24:20 INFO - blessings == 1.5.1 08:24:20 INFO - blobuploader == 1.2.4 08:24:20 INFO - docopt == 0.6.1 08:24:20 INFO - manifestparser == 1.1 08:24:20 INFO - mozInstall == 1.12 08:24:20 INFO - mozcrash == 0.16 08:24:20 INFO - mozdebug == 0.1 08:24:20 INFO - mozdevice == 0.47 08:24:20 INFO - mozfile == 1.2 08:24:20 INFO - mozhttpd == 0.7 08:24:20 INFO - mozinfo == 0.9 08:24:20 INFO - mozleak == 0.1 08:24:20 INFO - mozlog == 3.0 08:24:20 INFO - moznetwork == 0.27 08:24:20 INFO - mozprocess == 0.22 08:24:20 INFO - mozprofile == 0.27 08:24:20 INFO - mozrunner == 6.11 08:24:20 INFO - mozscreenshot == 0.1 08:24:20 INFO - mozsystemmonitor == 0.0 08:24:20 INFO - moztest == 0.7 08:24:20 INFO - mozversion == 1.4 08:24:20 INFO - psutil == 3.1.1 08:24:20 INFO - requests == 1.2.3 08:24:20 INFO - wsgiref == 0.1.2 08:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:20 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')]} 08:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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')]} 08:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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 0x7f90a6576c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d586c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e099a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, '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': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', '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 08:24:20 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 08:24:20 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 08:24:20 INFO - Using env: {'DISPLAY': ':0', 08:24:20 INFO - 'HOME': '/home/cltbld', 08:24:20 INFO - 'LANG': 'en_US.UTF-8', 08:24:20 INFO - 'LANGUAGE': 'en_US:en', 08:24:20 INFO - 'LOGNAME': 'cltbld', 08:24:20 INFO - 'MAIL': '/var/mail/cltbld', 08:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:20 INFO - 'MOZ_NO_REMOTE': '1', 08:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:20 INFO - 'NO_EM_RESTART': '1', 08:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:20 INFO - 'PWD': '/builds/slave/test', 08:24:20 INFO - 'SHELL': '/bin/bash', 08:24:20 INFO - 'SHLVL': '1', 08:24:20 INFO - 'TERM': 'linux', 08:24:20 INFO - 'TMOUT': '86400', 08:24:20 INFO - 'USER': 'cltbld', 08:24:20 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:20 INFO - '_': '/tools/buildbot/bin/python'} 08:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Running post-action listener: _resource_record_post_action 08:24:20 INFO - Running post-action listener: _start_resource_monitoring 08:24:20 INFO - Starting resource monitoring. 08:24:20 INFO - ##### 08:24:20 INFO - ##### Running install step. 08:24:20 INFO - ##### 08:24:20 INFO - Running pre-action listener: _resource_record_pre_action 08:24:20 INFO - Running main action method: install 08:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:21 INFO - Reading from file tmpfile_stdout 08:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:21 INFO - Reading from file tmpfile_stdout 08:24:21 INFO - Output received: 08:24:21 INFO - Usage: mozinstall [options] installer 08:24:21 INFO - Options: 08:24:21 INFO - -h, --help show this help message and exit 08:24:21 INFO - -d DEST, --destination=DEST 08:24:21 INFO - Directory to install application into. [default: 08:24:21 INFO - "/builds/slave/test"] 08:24:21 INFO - --app=APP Application being installed. [default: firefox] 08:24:21 INFO - mkdir: /builds/slave/test/build/application 08:24:21 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'] 08:24:21 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 08:24:35 INFO - Reading from file tmpfile_stdout 08:24:35 INFO - Output received: 08:24:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:35 INFO - Running post-action listener: _resource_record_post_action 08:24:35 INFO - ##### 08:24:35 INFO - ##### Running run-tests step. 08:24:35 INFO - ##### 08:24:35 INFO - Running pre-action listener: _resource_record_pre_action 08:24:35 INFO - Running main action method: run_tests 08:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:35 INFO - Python 2.7.3 08:24:35 INFO - Return code: 0 08:24:35 INFO - grabbing minidump binary from tooltool 08:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:35 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 0x1e98ac0>, '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 0x1e999a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:35 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 08:24:35 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 08:24:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:35 INFO - Return code: 0 08:24:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:35 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] in /builds/slave/test/build 08:24:35 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost 08:24:35 INFO - Using env: {'DISPLAY': ':0', 08:24:35 INFO - 'HOME': '/home/cltbld', 08:24:35 INFO - 'LANG': 'en_US.UTF-8', 08:24:35 INFO - 'LANGUAGE': 'en_US:en', 08:24:35 INFO - 'LOGNAME': 'cltbld', 08:24:35 INFO - 'MAIL': '/var/mail/cltbld', 08:24:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:35 INFO - 'MOZ_NO_REMOTE': '1', 08:24:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:35 INFO - 'NO_EM_RESTART': '1', 08:24:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:35 INFO - 'PWD': '/builds/slave/test', 08:24:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:35 INFO - 'SHELL': '/bin/bash', 08:24:35 INFO - 'SHLVL': '1', 08:24:35 INFO - 'TERM': 'linux', 08:24:35 INFO - 'TMOUT': '86400', 08:24:35 INFO - 'USER': 'cltbld', 08:24:35 INFO - 'XDG_SESSION_COOKIE': 'e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431', 08:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:35 INFO - '_': '/tools/buildbot/bin/python'} 08:24:35 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/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost'] with output_timeout 3600 08:24:35 INFO - mozversion INFO | application_buildid: 20151113072730 08:24:35 INFO - mozversion INFO | application_changeset: 97e1e855ec9ae5776ce04919f0da1d650d4f410f 08:24:35 INFO - mozversion INFO | application_display_name: Nightly 08:24:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:35 INFO - mozversion INFO | application_name: Firefox 08:24:35 INFO - mozversion INFO | application_remotingname: firefox 08:24:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:24:35 INFO - mozversion INFO | application_vendor: Mozilla 08:24:35 INFO - mozversion INFO | application_version: 45.0a1 08:24:35 INFO - mozversion INFO | platform_buildid: 20151113072730 08:24:35 INFO - mozversion INFO | platform_changeset: 97e1e855ec9ae5776ce04919f0da1d650d4f410f 08:24:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:24:35 INFO - mozversion INFO | platform_version: 45.0a1 08:24:35 INFO - 2015-11-13 08:24:35,478 DEBUG : using testdate: 1447431875 08:24:35 INFO - 2015-11-13 08:24:35,478 DEBUG : actual date: 1447431875 08:24:35 INFO - 2015-11-13 08:24:35,486 INFO : starting webserver on 'localhost:45548' 08:24:35 INFO - 2015-11-13 08:24:35,487 INFO : Starting test suite talos-linux64-ix-038.e 08:24:35 INFO - 2015-11-13 08:24:35,487 INFO : Starting test dromaeo_css 08:24:35 INFO - 2015-11-13 08:24:35,487 DEBUG : operating with platform_type : linux_ 08:24:35 INFO - 2015-11-13 08:24:35,488 INFO : Initialising browser for dromaeo_css test... 08:24:35 INFO - 2015-11-13 08:24:35,500 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaYDp1/profile http://localhost:45548/getInfo.html 08:24:42 INFO - 2015-11-13 08:24:42,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:24:42 INFO - 2015-11-13 08:24:42,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:24:42 INFO - 2015-11-13 08:24:42,386 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:24:42 INFO - 2015-11-13 08:24:42,386 DEBUG : BROWSER_OUTPUT: __metrics 08:24:43 INFO - 2015-11-13 08:24:43,673 INFO : Browser initialized. 08:24:43 INFO - 2015-11-13 08:24:43,674 INFO : Running cycle 1/1 for dromaeo_css test... 08:24:43 INFO - 2015-11-13 08:24:43,674 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaYDp1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:24:55 INFO - 2015-11-13 08:24:55,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 140673024 08:24:55 INFO - 2015-11-13 08:24:55,613 DEBUG : BROWSER_OUTPUT: 08:25:45 INFO - 2015-11-13 08:25:45,285 DEBUG : BROWSER_OUTPUT: 1447431945284 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] 08:27:56 INFO - 2015-11-13 08:27:56,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45548/tests/dromaeo/cssquery-ext.html) 08:27:57 INFO - 2015-11-13 08:27:57,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 143183872 08:27:57 INFO - 2015-11-13 08:27:57,692 DEBUG : BROWSER_OUTPUT: 08:30:59 INFO - 2015-11-13 08:30:59,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-ext.html (next: http://localhost:45548/tests/dromaeo/cssquery-jquery.html) 08:31:00 INFO - 2015-11-13 08:31:00,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 143200256 08:31:00 INFO - 2015-11-13 08:31:00,159 DEBUG : BROWSER_OUTPUT: 08:34:01 INFO - 2015-11-13 08:34:01,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45548/tests/dromaeo/cssquery-mootools.html) 08:34:02 INFO - 2015-11-13 08:34:02,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 141504512 08:34:02 INFO - 2015-11-13 08:34:02,515 DEBUG : BROWSER_OUTPUT: 08:37:04 INFO - 2015-11-13 08:37:04,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45548/tests/dromaeo/cssquery-prototype.html) 08:37:04 INFO - 2015-11-13 08:37:04,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 08:37:04 INFO - 2015-11-13 08:37:04,895 DEBUG : BROWSER_OUTPUT: 08:40:07 INFO - 2015-11-13 08:40:07,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45548/tests/dromaeo/cssquery-yui.html) 08:40:08 INFO - 2015-11-13 08:40:08,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 140353536 08:40:08 INFO - 2015-11-13 08:40:08,048 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/dromaeo/cssquery-yui.html (next: http://localhost:45548/tests/dromaeo/cssquery-dojo.html) 08:43:10 INFO - 2015-11-13 08:43:10,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 142934016 08:43:10 INFO - 2015-11-13 08:43:10,462 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,463 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:43:10 INFO - 2015-11-13 08:43:10,463 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:43:10 INFO - 2015-11-13 08:43:10,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:43:10 INFO - 2015-11-13 08:43:10,464 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:43:10 INFO - 2015-11-13 08:43:10,464 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2681.932951676209;2682.785377169826;2712.56598944169;2716.687580928193;2736.384313529456;4557.248054071082;4665.370175026374;4698.976505117478;4723.126221648993;4805.159097157996;4612.054528821592;4655.348251244828;4742.146413645542;4745.335653008581;4755.286706993953;4367.519572846984;4399.494058183318;4400.537943515933;4403.361512580674;4427.2695005324085;4422.137683151786;4430.911381772363;4497.730136191839;4501.122281155176;4538.455385353745;4188.811503482335;4267.231898258312;4290.077633308853;4410.3825464435;4419.359192917042;4378;4388.670849686287;4396.736195828261;4444.6666500012625;4455.777211139462;4194.958050419487;4322.913541729179;4369.060651959812;4405.22908491016;4427.490838553543;4606.631469482433;4675.064987002613;4771.28430735389;4804.519548045202;4819.156647586658;5049.899002019939;5067.265246539231;5073.264376665363;5089.211172268304;5099.872503187413;4905.975470122662;5027.84916452507;5121.897562048775;5128.666636668642;5149.45930677281;4712.952870471286;4772.117158325721;4781.545753153445;4796.328514008042;4842.58837998774;5228.581713462914;5237.895242095136;5259.368875734936;5260.237265596544;5276.261323414725;4858.271259311132;4940.2342636891335;4964.627652926045;5034.320366750515;5048.697078175322;5160.432352441228;5166;5172.8965420691375;5187.559057480156;5222.1383471727495;5098.388193416814;5102.413222479388;5110.029094472038;5113.207452844815;5155.123628983082;4791.976040119846;4888.071266459361;4973.403191617029;5068.062408454448;5086.745662716849;4253.744775313429;4256.021115143534;4266.807993640294;4271.444712187458;4280.443542339476;3771.5474143103;3774.150816066363;3774.471573979645;3778.848846046127;3780.5652349980105;4314.1371725655;4359.585839345257;4398.252297109499;4419.845305414359;4432.224360736858;5084.33903592538;5103.260027296022;5117.744112794346;5148.124818780816;5162.432132465426;4196.391523229115;4395.099004704028;4397.9560204398185;4431.556844315607;4434.246178149658;4431.645468362523;4486;4553.635709143261;4567.794449249792;4599.1721490132095;4851.95148048515;4880.170371036932;4892.584130348889;4939.357883475125;4964.900701986012;4937.333459982857;5167.689938603696;5202.609804264771;5204.661696989683;5245.947540524546;4665.976670116627;4706.552877476634;4726.26742854858;4755.595774359218;4760.833370832004;5052.216906379517;5109.6678715883345;5128.487151284991;5129.102407078821;5180.818671346636;4849.75751212445;4967.751612419437;5164.122099243063;5179.585633149414;5184.533391994739;4840.927386089141;4891.730954797378;4921.581665558468;4926.433460151985;4978.153713868724;4959.876003099807;4994.550490455877;5016.623753218596;5039.647224694236;5041.798328066836;4677.181493238738;4742.004179122285;4803.063402636452;4931.334269873521;4977.178765503651;4962.280469331855;4966.453690094015;4971.850844474671;4993.725345106054;5034.823781167642;4838.516148385133;4846.5638092571835;4853.466118727008;4869;4883.511648835088 08:43:10 INFO - 2015-11-13 08:43:10,465 DEBUG : BROWSER_OUTPUT: |1;ext.html;524.6484855147052;555.9416261292566;581.531866847188;583.8978178818709;586.3667239381468;28464.15733875926;36950.445743313874;37272.76363418193;37575.436368454495;37717.62282377175;39837.20325593494;40438;40483.19033619326;40560.79719601398;40645;7853.450258481908;8036.4776289541;8045.275925166734;8045.6781728731075;8053.879191812128;7941.32498737608;7986.1614530474335;7994.680212791482;8005.959970200141;8055.63749631268;7944.960275198616;8020.197980201991;8048.959755201216;8098.554579498125;8106.229908158715;7933.048034235871;7944.523328600302;7959.243871832166;7970;8024.67901283948;7768.7669369918995;7882.132965373804;7886.960565197194;7903.328217101496;7908.9604551977445;36949.63050369489;37276.44085338722;37441.81279093587;37477.437838432445;37503;2801.6918139004897;2897.3046468847538;2915.6355455568055;2991.8055326403933;3026.8486575671127;27628.30929226765;27807.443851122865;27854.5821812673;28334.14997550056;28397.432051359065;2613.451175253199;2629.250663560876;2652.82756620819;2691.327168207948;2728.7953403494816;219972;222769;223055;223400;224317.14889978772;51627;52614.21078683823;56132.438675613535;63444;63975;56226.43773562212;56521.71739141278;56732;56819.715901420226;56866.43133568612;12667.556635517896;12730.23618582888;12749.553765618159;12756.425960831784;12766.744665106646;10489.47552622381;10545.9472702636;10561.155107591374;10577.471126443646;10583.788324233472;19215.231390744495;19334.049409237436;19428.971098843227;19640.70538941917;19694.803051969582;7867.173946735625;7919.20807919215;8004.879926801103;8006.559639219782;8056.126043743568;854.5641722721457;906.419891269588;940.8071345374182;944.8393773058597;1031.128696251681;26197.607035894478;30030.549541756893;30685;31000.22499437532;31070;953.1516949914582;954.5609019850947;963.4749061761357;1050.8791488978713;1103.4648195625116;12780.808287875689;13413.195208287534;13556.45774169042;13607.11553749023;13627.863721362857;309106;311902;312546;312834;314217;46549.534504655196;47225.05549888983;47334;47390.76304618455;47400.7629961848;1200.5137919142762;1205.4635687119148;1206.6561030106377;1210.527894121311;1212.0545974140184;24930.50138997246;25185.49629007373;25329;25405;25480.23559293224;35549.82225088858;36681;36698;36811.26377472489;36847.815760921025;242119;243162;244012;245417;246081;29219.123426297247;41762.791186043876;43219.78390108029;43887.12225755403;43960;39825.40261896132;40098.79950600345;40194.1961160781;40939;41267.174656506104;34156.82921585376;34462.28632904315;34466.10436426021;34605.13487162841;35318.117047074025;34662.480062798575;34821;34899;34917.650823491436;35091.82454087815;34157.31685366329;34518.82740586281;34522;34740.652593474755;34852.47721284132;30117.3976520464;31162;31281.374372512877;31435.685643143275;31460.213494662818;24124.638130427706;24377.756222438256;24549.263522094367;24641.876790615934;24676 08:43:10 INFO - 2015-11-13 08:43:10,465 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.41229493059956;328.74358000759406;328.89310973933465;336.1445122164092;336.34077208671005;10770.569177232901;11067.280626759255;14950.10299382038;15454.768178477332;15513.92243038786;10381.377117372964;10593.629222977197;10711;10732.678019659403;10752.78494430111;4057.6348128668487;4160.2303573838935;4165.979170104145;4174.791260436981;4177.12280421112;4058.594140585947;4114.8148333324925;4134.813933373005;4139.379093136024;4186.958130418702;4097.385392191165;4100.36444351126;4401.36180253863;4516.41286632739;4521.841735539257;4486.439195100596;4505.797239124247;4508.278675411935;4521.412216411878;4530.70550414222;3827.674647654953;3900.161465284949;3918.3338832398563;3928.489296391451;3943.98028009861;11960.102992275613;12123.151379403445;12151.088668349821;12265.938670306681;12266.509339626404;1678.9160541972853;1704.2330951071942;1714.545645403969;1741.4949664597252;1754.1843042984945;9022.954885225598;9041.77395565116;9276.211522020636;9292.814143717156;9441;1587.5078725594988;1609.2758258783595;1609.452786052736;1637.8280280570489;1662.1356894414957;52380.21429678596;52792.208116878275;53696.463035369925;54207;54920.72539637276;6293.527985401021;6376.182787905424;6381.649009304533;6397.168368112116;6426.967865160737;7499.700011999459;7506.099268087864;7507.8498430031095;7511.51175173612;7546.886796698054;4976.5023497649945;4989.451160372356;4995.550400463903;5023.070731914608;5042.520960508746;4933.383327084114;5003.249512573143;5006.249062640633;5014;5033.79864805411;2957.216337670519;2972.539256415259;2977.35986762847;2982.120274519022;2986.4027194561177;1044.3525014491065;1044.9007344302279;1049.459528342904;1060.6764936694383;1107.7618312062784;386.53808698605457;388.5919784226607;391.74928046050553;404.6701937920585;428.8670512141246;9220.7694807629;9410;9559.94840567537;9694.951525242328;9893.109620134079;372.44877581180003;382.2622338885921;390.7069697726705;393.227308339115;403.38282427885383;5247.553957913544;5261.2641426458795;5272.789088436496;5295.814646487354;5394.91907621386;467484;470788;471137;473503;473634;66224.66887665627;69811.65094174497;70263;72021.27978720251;72102;461.40478782371036;464.03943836259293;467.67262915958963;469.5023275328163;473.8602112376857;10199.184065274612;10212.693619191436;10230.386176829414;10301.175905927657;10374.533146008598;32524.349513010082;33526;33683.494747579294;33986.32027359489;34477.65522344845;40579.79710101431;41879.37180942227;45635;46304.768476157406;47057;5959.22530071088;6142.9078563820685;6144.907826382697;6145.477634400947;6158.938410615837;10067.446290454096;10399.48002599882;10406.895931040593;10563.577456901638;10607.734806629896;7849.411294152847;9066;9084.000759916536;9186.54067296646;9660.033996600283;8895.332850036144;9204.355695101278;9406.38858474197;9491.762705932408;9643;9485.478298693639;9537.284703647116;9708.708738737849;9723.805523889341;9808.950955245178;6103.267607887082;6104.816855494342;6117.357677443804;6127.754889804358;6137.140800287874;9347.065293470598;9492.335536512377;9664.130228279208;9746.9025309746;9798.706038818847 08:43:10 INFO - 2015-11-13 08:43:10,469 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1466.9438004636659;1629.2179753718215;1652.719037763581;1681.445123109374;1704.2671651189987;6659.533832631718;6775.254721980578;6866.622335771531;6956.965215173924;6976.1628604567395;7118.822029449267;7152.713891444336;7171.390431813289;7199.964000179992;7207.0630817993715;1992.8306093981992;2027.9391618251475;2043.56063446359;2048.2831009146753;2057.86623869448;1992.1135094882784;2038.6228547718645;2039.0212697905015;2054.6096241714026;2065.8863762493056;1915.7126431035385;1965.9606807863834;1969.3599580136513;2020.8686435381726;2044.1516770540209;2002.1991203518564;2005.2780998840406;2006.3379084901946;2027.888466134362;2035.7964203579672;1984.4344361856945;2010.9296174633964;2011.4267433781301;2034.08466190215;2038.6330460517102;6922.5154239203275;7050.5769653820425;7063.964680176567;7066.0814094167945;7085.858282834366;4041.211963667086;4086.9182616347507;4092.897677558085;4101.179764047172;4122.196171746511;2630.013744845683;2659.521286168489;2705.4318593095472;2709.7967652426146;2728.2224565998595;811.8335741173105;811.9431639785217;818.3453237410048;829.1666874790857;862.6894318045498;9431.198348140417;9459.858102128474;9469.763255918588;9505.952470237673;9560.76098097553;3725.869594564177;3781.470594116826;3810.0855794609092;3819.751716138442;3819.9045023874623;7833.725819596287;7850.489718168301;7856.921430785734;7865.292123708894;7898.684052637945;4213.094184750294;4242.44848169736;4252.936205956913;4260.872173834728;4268.274393353137;3866.4393662919283;3866.613338666111;3911.2568611963634;3917.1578110706337;3926.018495376156;3097.7212050915527;3137.2470607054142;3148.937021259562;3163.636181839072;3172.8730850766174;882.8366752150872;899.9910000900038;912.1790388650135;914.1772404835568;915.9267258619294;818.0960039156765;869.852125138728;875.0461996423801;946.2619157057507;971.4754032822339;6533.18335208099;6550;6566;6607.933920660732;6639.502037347122;1024.9795004099876;1027.5735569738624;1051.5846240734868;1068.9251752377415;1076.4025965589174;5354.357477102694;5368.3826359968325;5372.435894231049;5399.946000540023;5404.8108316208745;8233.711820086268;8268.173182681803;8420.115887831813;8447.239748422671;8456.534890581077;8321.876546666244;8333.125021872738;8337.666493340319;8349.707760228363;8371.874421883676;6511.609303441714;6656.70044847983;6734.797956061326;6755.493337999571;6782.762603308861;6642.933570664231;6650.90023649636;6705.09481220029;6708.731650733916;6762.695678694372;7437.330640242404;7519.699212031457;7574.356179724785;7675.654595543102;7693.4614576979075;7505.399568034435;7619.428542859197;7766.262205090507;7780.533168009937;7855.057393112863;6145.600535965148;6146.108814222002;6182.196314479089;6212.658303793335;6231.626102433868;6683.9331606685255;6684.4318232950745;6717.529772915849;6722.529422940347;6824.965875170592;6312.589681670676;6389.201349831271;6399.136116624382;6469.5794773339585;6578.703958321791;5458.972705136449;6327.96836015817;6340.619562826245;6341.49268058545;6447.4197322241225;6465.22417309907;6471.708773105316;6481.837954051187;6484.967575162283;6494.675266236574;5866.061430171152;5902.439268269508;5917.349091600006;5922;5924.081767326072;6012.278526576839;6037.335893051673;6057.575969682256;6068.271807383142;6071.817845464643 08:43:10 INFO - 2015-11-13 08:43:10,470 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.42027423507574;286.0731230812168;291.9708029197079;291.99708002919976;295.96448426188863;5508;5647.322321321442;5728.770849166029;5733.111367738002;5841.941580584204;5686.5735069869825;5687.345955215152;5696.6866822324755;5698.772049118041;5709.914351284734;4306.655467562603;4324.82700691972;4325.740455572668;4342.478902531685;4343.913121737563;4315.805788739499;4324.502682191557;4333.588309110645;4343.6959412841115;4343.9348409773875;4200.138971510848;4256.765877876715;4268.103698223361;4275.636570891463;4281.807318670667;4262.25410553152;4268.893277668052;4276.102018576072;4278.893027674333;4284.378765079077;3675.3016926784094;3695.4087346024776;3701.722370822199;3702.0559757261994;3705.6479634434686;5457.727113644302;5467.480589344006;5472.91790623141;5474.589405794582;5477.835664930059;4649.814007439699;4814.879628009293;4921.803127874917;4926.2118061110405;4950.034743225073;5720.542356611461;5898.557608179403;5904.114382842565;5912.201852749867;5928.318243401977;3910.765354078736;3918.1967696622123;3928.332183528807;3932.370820668708;3951.980240098781;6154.815355539341;6241;6256.280527739323;6268.122462855204;6270.561060725706;3969.4244334571326;4023.1350259693722;4024.91950161001;4050.210209009274;4056.1887622475624;4112.115895082572;4123.690723195772;4133.152703695735;4133.23535145999;4139.2135494256;4800.375951126401;4808.374911261513;4817.397825271841;4823.2282834746975;4825.131476334223;5900.1739756434135;5909.113632955005;5915;5926.614770039933;5934.851628709317;1406.1773862290675;1431.77807439847;1454.1711224602086;1464.348364977596;1465.7947887295786;944.3342443577261;951.7049714588361;955.1737746848926;966.21253678252;967.6516454076527;5038.672486288379;5047.772850221749;5063.1898896176435;5064.5441910228255;5094.5160209780015;6038.275406951194;6048.788292409832;6055.969720151459;6068.878622427526;6080.2399700037495;5024.422191447957;5042.773075211624;5061.468545802712;5065.936153407752;5066.620003499678;3227.064151396069;3281.4585593376823;3288.917777055593;3294.7364210863075;3300.9834950825093;5608.523275521545;5649.491545760901;5652.406497317723;5666.518345940642;5667.858303542444;6226.128342032119;6236.126942228092;6237.09562113491;6237.844053898689;6245.0632405139595;5667.348254950651;5670.5747068969995;5678.233438485834;5877.794277200277;5883.058710606282;6198.380161983946;6220.129181914626;6243.687815609293;6252.656103914146;6254.249490061222;6019.578629495893;6028.3971602839365;6055.455009049207;6076.088586711851;6078.878422431439;5646.576506761927;5791.378414044075;5845.8538536535225;5846.1815345852465;5862.765489380377;4018.0557568971853;4055.270051390778;4056.046828995243;4066.776327302027;4076.062505623664;6254.405831446005;6267.62394256346;6274.466670333073;6275.592086514362;6284.371562843679;5959.940400595939;6004.339522652592;6006.3693312201585;6015.608985415934;6017.338092809875;5784.161296612052;5985.162077309094;5985.431384018511;5989.460948514655;6016.187814644967;5829.446202610915;5868.970655146697;5884.558658100574;5888.263967004124;5893.941060589339;5971.940280597139;6029.969850150721;6039.818805435844;6042.848928776816;6076.331603523698;5721.141828725558;5817.534597232296;5821.068629019336;5853.590248682552;5862.413758624103 08:43:10 INFO - 2015-11-13 08:43:10,474 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.157868712447;780.9882851757225;783.7609529093626;793.4921650143913;794.936405087593;11929.343886086273;12119.030477561795;12201;12202.267863928171;12225.633231003074;11802.940985295061;12077.214981026249;12138;12146.453409596566;12201.572944946929;777.9922200777991;781.4607920534813;794.0590400375545;795.1769918134731;795.5226863881683;788.7239466186846;792.3977776889548;793.4763056382789;795.8288967871906;796.7848680856165;827.9130691277419;836.9414141010132;838.3502785341378;839.4375768235267;840.315143158324;826.8057006603443;831.9292860106838;832.1927730101792;833.1793183714037;834.862247729124;612.1613389656155;612.457974692396;613.2640831002769;614.5452365249728;615.5691016288616;11947.880521194764;11956.043516518657;11987;12003.399830008464;12022.63932082039;11622.360770157638;11696.122790790725;11735.178537502377;11962.461689224006;12028.699282518008;9059.271396959457;9293.674721384787;9339.719808405758;9503.619855205852;9579.856302155473;2898.3623602807347;2900.2459360566404;2938.823670579772;2947.8083924544835;3000.009996701105;36702.449463258075;37186.628133718856;37234.25531489355;37336;37393.25213495742;6414.294427612959;6648.933510664831;6772.11962444879;6867.278935711778;6873.748892053655;10400.219983501116;10515.684529464128;10519.421431821323;10530.578776848994;10600.204984626183;5748.425157484218;5909.261342332208;5962.07587823888;6036.8188954331445;6040.973034584131;3679.0986208379118;3781.1870447853844;3809.4857194278416;3827.2154208387215;3827.6363745444137;2435.4033261850605;2448.1186772761794;2461.0524947895187;2465.6671349367966;2481.1440053181623;383.5914750790399;384.45983393332415;387.8157875009348;388.3921662598025;389.6240128276227;437.531840930208;438.4610018833916;445.8105305245323;449.5841346754239;486.6885193476178;7630.923690763021;7747.418943579141;8016.238457346542;8317.584120793936;8711.259542938795;481.71097341595464;486.45167682171416;545.3673738463364;596.7165596341703;636.8567072408764;3727.2731817295366;3736.308782875177;3742.2328422673286;3752.1745216052423;3827.158025234444;54745;55223;55806.44193558094;55918.16122758162;56400.71799640975;40798;44962.77518612451;47090.5290947093;49676.50323496719;49876.25185622219;43194.13611727748;43530.7823460887;44425;44846.103077938256;45027.77486112614;8119;8154.633041513028;8185.30424913889;8440.198181172778;8501.447405918596;30521.08436746901;30754.846225768728;31340.865913408477;33483;33759.98720038403;39608.40587391249;42379.576204238794;42919.356209657504;43205;43355;6599.637019963948;6607.834804129935;6799.864002719819;6875.7937261882225;7080.610566418896;11078;11230.213885028297;11278.436078196222;11301.547938082385;11489.770204596029;10676.14590832716;10762.246642734934;10839.67480975572;11089.500972456097;11200.607978720705;10356.275060745977;10508.422036787744;10534.525946332587;10559.260851740304;10648.84026739584;10790.460476975963;10800.567977280822;10801.081908037904;10865.891341086488;10906.236563440483;9184.448933064037;9340.626374945197;9448.905510945078;9690.56392462355;9741.123298902849;8747.212750852454;8942.73171804847;8946.552672366486;9201.723948281562;9205.677801276923 08:43:10 INFO - 2015-11-13 08:43:10,474 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:43:10 INFO - 2015-11-13 08:43:10,474 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:43:10 INFO - 2015-11-13 08:43:10,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 08:43:10 INFO - 2015-11-13 08:43:10,475 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:43:10 INFO - 2015-11-13 08:43:10,475 DEBUG : BROWSER_OUTPUT: __startTimestamp1447432990462__endTimestamp 08:43:10 INFO - 2015-11-13 08:43:10,475 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,475 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:43:10 INFO - 2015-11-13 08:43:10,475 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:43:10 INFO - 2015-11-13 08:43:10,476 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,476 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4702.98 Median:4819.16 stddev:494.46 (10.3%) stddev-sans-first:469.87 08:43:10 INFO - 2015-11-13 08:43:10,476 DEBUG : BROWSER_OUTPUT: Values: 2681.9 2682.8 2712.6 2716.7 2736.4 4557.2 4665.4 4699.0 4723.1 4805.2 4612.1 4655.3 4742.1 4745.3 4755.3 4367.5 4399.5 4400.5 4403.4 4427.3 4422.1 4430.9 4497.7 4501.1 4538.5 4188.8 4267.2 4290.1 4410.4 4419.4 4378.0 4388.7 4396.7 4444.7 4455.8 4195.0 4322.9 4369.1 4405.2 4427.5 4606.6 4675.1 4771.3 4804.5 4819.2 5049.9 5067.3 5073.3 5089.2 5099.9 4906.0 5027.8 5121.9 5128.7 5149.5 4713.0 4772.1 4781.5 4796.3 4842.6 5228.6 5237.9 5259.4 5260.2 5276.3 4858.3 4940.2 4964.6 5034.3 5048.7 5160.4 5166.0 5172.9 5187.6 5222.1 5098.4 5102.4 5110.0 5113.2 5155.1 4792.0 4888.1 4973.4 5068.1 5086.7 4253.7 4256.0 4266.8 4271.4 4280.4 3771.5 3774.2 3774.5 3778.8 3780.6 4314.1 4359.6 4398.3 4419.8 4432.2 5084.3 5103.3 5117.7 5148.1 5162.4 4196.4 4395.1 4398.0 4431.6 4434.2 4431.6 4486.0 4553.6 4567.8 4599.2 4852.0 4880.2 4892.6 4939.4 4964.9 4937.3 5167.7 5202.6 5204.7 5245.9 4666.0 4706.6 4726.3 4755.6 4760.8 5052.2 5109.7 5128.5 5129.1 5180.8 4849.8 4967.8 5164.1 5179.6 5184.5 4840.9 4891.7 4921.6 4926.4 4978.2 4959.9 4994.6 5016.6 5039.6 5041.8 4677.2 4742.0 4803.1 4931.3 4977.2 4962.3 4966.5 4971.9 4993.7 5034.8 4838.5 4846.6 4853.5 4869.0 4883.5 08:43:10 INFO - 2015-11-13 08:43:10,476 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,476 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42417.76 Median:34875.74 stddev:68564.53 (196.6%) stddev-sans-first:68684.72 08:43:10 INFO - 2015-11-13 08:43:10,478 DEBUG : BROWSER_OUTPUT: Values: 524.6 555.9 581.5 583.9 586.4 28464.2 36950.4 37272.8 37575.4 37717.6 39837.2 40438.0 40483.2 40560.8 40645.0 7853.5 8036.5 8045.3 8045.7 8053.9 7941.3 7986.2 7994.7 8006.0 8055.6 7945.0 8020.2 8049.0 8098.6 8106.2 7933.0 7944.5 7959.2 7970.0 8024.7 7768.8 7882.1 7887.0 7903.3 7909.0 36949.6 37276.4 37441.8 37477.4 37503.0 2801.7 2897.3 2915.6 2991.8 3026.8 27628.3 27807.4 27854.6 28334.1 28397.4 2613.5 2629.3 2652.8 2691.3 2728.8 219972.0 222769.0 223055.0 223400.0 224317.1 51627.0 52614.2 56132.4 63444.0 63975.0 56226.4 56521.7 56732.0 56819.7 56866.4 12667.6 12730.2 12749.6 12756.4 12766.7 10489.5 10545.9 10561.2 10577.5 10583.8 19215.2 19334.0 19429.0 19640.7 19694.8 7867.2 7919.2 8004.9 8006.6 8056.1 854.6 906.4 940.8 944.8 1031.1 26197.6 30030.5 30685.0 31000.2 31070.0 953.2 954.6 963.5 1050.9 1103.5 12780.8 13413.2 13556.5 13607.1 13627.9 309106.0 311902.0 312546.0 312834.0 314217.0 46549.5 47225.1 47334.0 47390.8 47400.8 1200.5 1205.5 1206.7 1210.5 1212.1 24930.5 25185.5 25329.0 25405.0 25480.2 35549.8 36681.0 36698.0 36811.3 36847.8 242119.0 243162.0 244012.0 245417.0 246081.0 29219.1 41762.8 43219.8 43887.1 43960.0 39825.4 40098.8 40194.2 40939.0 41267.2 34156.8 34462.3 34466.1 34605.1 35318.1 34662.5 34821.0 34899.0 34917.7 35091.8 34157.3 34518.8 34522.0 34740.7 34852.5 30117.4 31162.0 31281.4 31435.7 31460.2 24124.6 24377.8 24549.3 24641.9 24676.0 08:43:10 INFO - 2015-11-13 08:43:10,478 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,478 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23823.93 Median:4526.27 stddev:77341.01 (1708.7%) stddev-sans-first:77537.84 08:43:10 INFO - 2015-11-13 08:43:10,479 DEBUG : BROWSER_OUTPUT: Values: 327.4 328.7 328.9 336.1 336.3 10770.6 11067.3 14950.1 15454.8 15513.9 10381.4 10593.6 10711.0 10732.7 10752.8 4057.6 4160.2 4166.0 4174.8 4177.1 4058.6 4114.8 4134.8 4139.4 4187.0 4097.4 4100.4 4401.4 4516.4 4521.8 4486.4 4505.8 4508.3 4521.4 4530.7 3827.7 3900.2 3918.3 3928.5 3944.0 11960.1 12123.2 12151.1 12265.9 12266.5 1678.9 1704.2 1714.5 1741.5 1754.2 9023.0 9041.8 9276.2 9292.8 9441.0 1587.5 1609.3 1609.5 1637.8 1662.1 52380.2 52792.2 53696.5 54207.0 54920.7 6293.5 6376.2 6381.6 6397.2 6427.0 7499.7 7506.1 7507.8 7511.5 7546.9 4976.5 4989.5 4995.6 5023.1 5042.5 4933.4 5003.2 5006.2 5014.0 5033.8 2957.2 2972.5 2977.4 2982.1 2986.4 1044.4 1044.9 1049.5 1060.7 1107.8 386.5 388.6 391.7 404.7 428.9 9220.8 9410.0 9559.9 9695.0 9893.1 372.4 382.3 390.7 393.2 403.4 5247.6 5261.3 5272.8 5295.8 5394.9 467484.0 470788.0 471137.0 473503.0 473634.0 66224.7 69811.7 70263.0 72021.3 72102.0 461.4 464.0 467.7 469.5 473.9 10199.2 10212.7 10230.4 10301.2 10374.5 32524.3 33526.0 33683.5 33986.3 34477.7 40579.8 41879.4 45635.0 46304.8 47057.0 5959.2 6142.9 6144.9 6145.5 6158.9 10067.4 10399.5 10406.9 10563.6 10607.7 7849.4 9066.0 9084.0 9186.5 9660.0 8895.3 9204.4 9406.4 9491.8 9643.0 9485.5 9537.3 9708.7 9723.8 9809.0 6103.3 6104.8 6117.4 6127.8 6137.1 9347.1 9492.3 9664.1 9746.9 9798.7 08:43:10 INFO - 2015-11-13 08:43:10,479 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,479 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4915.08 Median:6394.17 stddev:2549.42 (39.9%) stddev-sans-first:2543.40 08:43:10 INFO - 2015-11-13 08:43:10,480 DEBUG : BROWSER_OUTPUT: Values: 1466.9 1629.2 1652.7 1681.4 1704.3 6659.5 6775.3 6866.6 6957.0 6976.2 7118.8 7152.7 7171.4 7200.0 7207.1 1992.8 2027.9 2043.6 2048.3 2057.9 1992.1 2038.6 2039.0 2054.6 2065.9 1915.7 1966.0 1969.4 2020.9 2044.2 2002.2 2005.3 2006.3 2027.9 2035.8 1984.4 2010.9 2011.4 2034.1 2038.6 6922.5 7050.6 7064.0 7066.1 7085.9 4041.2 4086.9 4092.9 4101.2 4122.2 2630.0 2659.5 2705.4 2709.8 2728.2 811.8 811.9 818.3 829.2 862.7 9431.2 9459.9 9469.8 9506.0 9560.8 3725.9 3781.5 3810.1 3819.8 3819.9 7833.7 7850.5 7856.9 7865.3 7898.7 4213.1 4242.4 4252.9 4260.9 4268.3 3866.4 3866.6 3911.3 3917.2 3926.0 3097.7 3137.2 3148.9 3163.6 3172.9 882.8 900.0 912.2 914.2 915.9 818.1 869.9 875.0 946.3 971.5 6533.2 6550.0 6566.0 6607.9 6639.5 1025.0 1027.6 1051.6 1068.9 1076.4 5354.4 5368.4 5372.4 5399.9 5404.8 8233.7 8268.2 8420.1 8447.2 8456.5 8321.9 8333.1 8337.7 8349.7 8371.9 6511.6 6656.7 6734.8 6755.5 6782.8 6642.9 6650.9 6705.1 6708.7 6762.7 7437.3 7519.7 7574.4 7675.7 7693.5 7505.4 7619.4 7766.3 7780.5 7855.1 6145.6 6146.1 6182.2 6212.7 6231.6 6683.9 6684.4 6717.5 6722.5 6825.0 6312.6 6389.2 6399.1 6469.6 6578.7 5459.0 6328.0 6340.6 6341.5 6447.4 6465.2 6471.7 6481.8 6485.0 6494.7 5866.1 5902.4 5917.3 5922.0 5924.1 6012.3 6037.3 6057.6 6068.3 6071.8 08:43:10 INFO - 2015-11-13 08:43:10,481 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,481 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4871.89 Median:5659.46 stddev:1479.40 (26.1%) stddev-sans-first:1442.87 08:43:10 INFO - 2015-11-13 08:43:10,481 DEBUG : BROWSER_OUTPUT: Values: 281.4 286.1 292.0 292.0 296.0 5508.0 5647.3 5728.8 5733.1 5841.9 5686.6 5687.3 5696.7 5698.8 5709.9 4306.7 4324.8 4325.7 4342.5 4343.9 4315.8 4324.5 4333.6 4343.7 4343.9 4200.1 4256.8 4268.1 4275.6 4281.8 4262.3 4268.9 4276.1 4278.9 4284.4 3675.3 3695.4 3701.7 3702.1 3705.6 5457.7 5467.5 5472.9 5474.6 5477.8 4649.8 4814.9 4921.8 4926.2 4950.0 5720.5 5898.6 5904.1 5912.2 5928.3 3910.8 3918.2 3928.3 3932.4 3952.0 6154.8 6241.0 6256.3 6268.1 6270.6 3969.4 4023.1 4024.9 4050.2 4056.2 4112.1 4123.7 4133.2 4133.2 4139.2 4800.4 4808.4 4817.4 4823.2 4825.1 5900.2 5909.1 5915.0 5926.6 5934.9 1406.2 1431.8 1454.2 1464.3 1465.8 944.3 951.7 955.2 966.2 967.7 5038.7 5047.8 5063.2 5064.5 5094.5 6038.3 6048.8 6056.0 6068.9 6080.2 5024.4 5042.8 5061.5 5065.9 5066.6 3227.1 3281.5 3288.9 3294.7 3301.0 5608.5 5649.5 5652.4 5666.5 5667.9 6226.1 6236.1 6237.1 6237.8 6245.1 5667.3 5670.6 5678.2 5877.8 5883.1 6198.4 6220.1 6243.7 6252.7 6254.2 6019.6 6028.4 6055.5 6076.1 6078.9 5646.6 5791.4 5845.9 5846.2 5862.8 4018.1 4055.3 4056.0 4066.8 4076.1 6254.4 6267.6 6274.5 6275.6 6284.4 5959.9 6004.3 6006.4 6015.6 6017.3 5784.2 5985.2 5985.4 5989.5 6016.2 5829.4 5869.0 5884.6 5888.3 5893.9 5971.9 6030.0 6039.8 6042.8 6076.3 5721.1 5817.5 5821.1 5853.6 5862.4 08:43:10 INFO - 2015-11-13 08:43:10,481 DEBUG : BROWSER_OUTPUT: 08:43:10 INFO - 2015-11-13 08:43:10,481 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12289.74 Median:22435.41 stddev:14672.48 (65.4%) stddev-sans-first:14688.16 08:43:10 INFO - 2015-11-13 08:43:10,483 DEBUG : BROWSER_OUTPUT: Values: 776.2 781.0 783.8 793.5 794.9 11929.3 12119.0 12201.0 12202.3 12225.6 11802.9 12077.2 12138.0 12146.5 12201.6 778.0 781.5 794.1 795.2 795.5 788.7 792.4 793.5 795.8 796.8 827.9 836.9 838.4 839.4 840.3 826.8 831.9 832.2 833.2 834.9 612.2 612.5 613.3 614.5 615.6 11947.9 11956.0 11987.0 12003.4 12022.6 11622.4 11696.1 11735.2 11962.5 12028.7 9059.3 9293.7 9339.7 9503.6 9579.9 2898.4 2900.2 2938.8 2947.8 3000.0 36702.4 37186.6 37234.3 37336.0 37393.3 6414.3 6648.9 6772.1 6867.3 6873.7 10400.2 10515.7 10519.4 10530.6 10600.2 5748.4 5909.3 5962.1 6036.8 6041.0 3679.1 3781.2 3809.5 3827.2 3827.6 2435.4 2448.1 2461.1 2465.7 2481.1 383.6 384.5 387.8 388.4 389.6 437.5 438.5 445.8 449.6 486.7 7630.9 7747.4 8016.2 8317.6 8711.3 481.7 486.5 545.4 596.7 636.9 3727.3 3736.3 3742.2 3752.2 3827.2 54745.0 55223.0 55806.4 55918.2 56400.7 40798.0 44962.8 47090.5 49676.5 49876.3 43194.1 43530.8 44425.0 44846.1 45027.8 8119.0 8154.6 8185.3 8440.2 8501.4 30521.1 30754.8 31340.9 33483.0 33760.0 39608.4 42379.6 42919.4 43205.0 43355.0 6599.6 6607.8 6799.9 6875.8 7080.6 11078.0 11230.2 11278.4 11301.5 11489.8 10676.1 10762.2 10839.7 11089.5 11200.6 10356.3 10508.4 10534.5 10559.3 10648.8 10790.5 10800.6 10801.1 10865.9 10906.2 9184.4 9340.6 9448.9 9690.6 9741.1 8747.2 8942.7 8946.6 9201.7 9205.7 08:43:10 INFO - 2015-11-13 08:43:10,483 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:43:10 INFO - 2015-11-13 08:43:10,483 DEBUG : BROWSER_OUTPUT: 08:43:11 INFO - 2015-11-13 08:43:11,209 INFO : Browser exited with error code: 0 08:43:11 INFO - 2015-11-13 08:43:11,228 INFO : Completed test dromaeo_css (00:18:35) 08:43:11 INFO - 2015-11-13 08:43:11,228 INFO : Starting test kraken 08:43:11 INFO - 2015-11-13 08:43:11,228 DEBUG : operating with platform_type : linux_ 08:43:11 INFO - 2015-11-13 08:43:11,228 INFO : Initialising browser for kraken test... 08:43:11 INFO - 2015-11-13 08:43:11,234 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQbBdD/profile http://localhost:45548/getInfo.html 08:43:16 INFO - 2015-11-13 08:43:16,452 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:43:16 INFO - 2015-11-13 08:43:16,453 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:43:16 INFO - 2015-11-13 08:43:16,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:43:16 INFO - 2015-11-13 08:43:16,453 DEBUG : BROWSER_OUTPUT: __metrics 08:43:17 INFO - 2015-11-13 08:43:17,589 INFO : Browser initialized. 08:43:17 INFO - 2015-11-13 08:43:17,590 INFO : Running cycle 1/1 for kraken test... 08:43:17 INFO - 2015-11-13 08:43:17,590 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQbBdD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:43:29 INFO - 2015-11-13 08:43:29,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 140922880 08:43:29 INFO - 2015-11-13 08:43:29,555 DEBUG : BROWSER_OUTPUT: 08:43:32 INFO - 2015-11-13 08:43:32,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45548/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:32 INFO - 2015-11-13 08:43:32,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 142282752 08:43:32 INFO - 2015-11-13 08:43:32,812 DEBUG : BROWSER_OUTPUT: 08:43:35 INFO - 2015-11-13 08:43:35,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45548/tests/kraken/driver.html?testName=audio-dft) 08:43:36 INFO - 2015-11-13 08:43:36,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 141258752 08:43:36 INFO - 2015-11-13 08:43:36,176 DEBUG : BROWSER_OUTPUT: 08:43:39 INFO - 2015-11-13 08:43:39,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45548/tests/kraken/driver.html?testName=audio-fft) 08:43:39 INFO - 2015-11-13 08:43:39,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 136720384 08:43:39 INFO - 2015-11-13 08:43:39,664 DEBUG : BROWSER_OUTPUT: 08:43:41 INFO - 2015-11-13 08:43:41,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45548/tests/kraken/driver.html?testName=audio-oscillator) 08:43:42 INFO - 2015-11-13 08:43:42,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 136482816 08:43:42 INFO - 2015-11-13 08:43:42,317 DEBUG : BROWSER_OUTPUT: 08:43:44 INFO - 2015-11-13 08:43:44,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:45 INFO - 2015-11-13 08:43:45,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 137699328 08:43:45 INFO - 2015-11-13 08:43:45,137 DEBUG : BROWSER_OUTPUT: 08:43:48 INFO - 2015-11-13 08:43:48,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45548/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:48 INFO - 2015-11-13 08:43:48,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 138137600 08:43:48 INFO - 2015-11-13 08:43:48,782 DEBUG : BROWSER_OUTPUT: 08:43:52 INFO - 2015-11-13 08:43:52,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45548/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:52 INFO - 2015-11-13 08:43:52,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 139489280 08:43:52 INFO - 2015-11-13 08:43:52,821 DEBUG : BROWSER_OUTPUT: 08:43:55 INFO - 2015-11-13 08:43:55,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45548/tests/kraken/driver.html?testName=json-parse-financial) 08:43:56 INFO - 2015-11-13 08:43:56,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 08:43:56 INFO - 2015-11-13 08:43:56,317 DEBUG : BROWSER_OUTPUT: 08:43:58 INFO - 2015-11-13 08:43:58,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:58 INFO - 2015-11-13 08:43:58,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 138268672 08:43:58 INFO - 2015-11-13 08:43:58,688 DEBUG : BROWSER_OUTPUT: 08:44:00 INFO - 2015-11-13 08:44:00,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:01 INFO - 2015-11-13 08:44:01,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 138080256 08:44:01 INFO - 2015-11-13 08:44:01,175 DEBUG : BROWSER_OUTPUT: 08:44:03 INFO - 2015-11-13 08:44:03,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:03 INFO - 2015-11-13 08:44:03,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 08:44:03 INFO - 2015-11-13 08:44:03,902 DEBUG : BROWSER_OUTPUT: 08:44:06 INFO - 2015-11-13 08:44:06,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:07 INFO - 2015-11-13 08:44:07,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 08:44:07 INFO - 2015-11-13 08:44:07,077 DEBUG : BROWSER_OUTPUT: 08:44:09 INFO - 2015-11-13 08:44:09,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:10 INFO - 2015-11-13 08:44:10,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 08:44:10 INFO - 2015-11-13 08:44:10,233 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45548/tests/kraken/driver.html?testName=ai-astar) 08:44:12 INFO - 2015-11-13 08:44:12,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 139407360 08:44:12 INFO - 2015-11-13 08:44:12,274 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:12 INFO - 2015-11-13 08:44:12,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:12 INFO - 2015-11-13 08:44:12,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:12 INFO - 2015-11-13 08:44:12,275 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:12 INFO - 2015-11-13 08:44:12,275 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;113;113;114;123;111;112;112;114 08:44:12 INFO - 2015-11-13 08:44:12,275 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;139;157;166;134;160;158;132;169;132 08:44:12 INFO - 2015-11-13 08:44:12,275 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;166;164;163;162;166;166;164;164;162 08:44:12 INFO - 2015-11-13 08:44:12,276 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;75;73;78;77;133;74;72;73;73 08:44:12 INFO - 2015-11-13 08:44:12,276 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;127;93;91;93;135;94;93;132 08:44:12 INFO - 2015-11-13 08:44:12,276 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;110;111;110;111;109 08:44:12 INFO - 2015-11-13 08:44:12,276 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;148;147;148;147;147;147;147;149;147 08:44:12 INFO - 2015-11-13 08:44:12,276 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;97;96;96;97;97;96;96;96 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;74;74;74;75;74;74;76;72 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;66;68;66;66;67;67;67 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;87;88;84;84;87;86;87 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;125;133;122;125;128;129;129;128 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;146;137;145;147;150;145;149;140;133 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;69;73;69;74;71;75;71 08:44:12 INFO - 2015-11-13 08:44:12,277 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:12 INFO - 2015-11-13 08:44:12,278 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:44:12 INFO - 2015-11-13 08:44:12,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,777 08:44:12 INFO - 2015-11-13 08:44:12,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:44:12 INFO - 2015-11-13 08:44:12,278 DEBUG : BROWSER_OUTPUT: __startTimestamp1447433052272__endTimestamp 08:44:12 INFO - 2015-11-13 08:44:12,278 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:12 INFO - 2015-11-13 08:44:12,281 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:3.69 (3.3%) stddev-sans-first:3.91 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 113.0 113.0 114.0 123.0 111.0 112.0 112.0 114.0 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.50 stddev:14.54 (9.2%) stddev-sans-first:15.22 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: Values: 157.0 139.0 157.0 166.0 134.0 160.0 158.0 132.0 169.0 132.0 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,282 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.56 (1.0%) stddev-sans-first:1.62 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: Values: 163.0 166.0 164.0 163.0 162.0 166.0 166.0 164.0 164.0 162.0 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:18.65 (25.2%) stddev-sans-first:19.64 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 73.0 78.0 77.0 133.0 74.0 72.0 73.0 73.0 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:92.50 stddev:18.91 (20.4%) stddev-sans-first:19.55 08:44:12 INFO - 2015-11-13 08:44:12,283 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 127.0 93.0 91.0 93.0 135.0 94.0 93.0 132.0 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 110.0 111.0 110.0 111.0 109.0 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.06 (0.7%) stddev-sans-first:0.73 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: Values: 150.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 149.0 147.0 08:44:12 INFO - 2015-11-13 08:44:12,284 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.00 Median:74.00 stddev:1.05 (1.4%) stddev-sans-first:1.12 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 74.0 74.0 74.0 75.0 74.0 74.0 76.0 72.0 08:44:12 INFO - 2015-11-13 08:44:12,285 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,285 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 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 66.0 68.0 66.0 66.0 67.0 67.0 67.0 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:1.72 (2.0%) stddev-sans-first:1.56 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 87.0 88.0 84.0 84.0 87.0 86.0 87.0 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.00 stddev:3.60 (2.8%) stddev-sans-first:3.60 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 125.0 133.0 122.0 125.0 128.0 129.0 129.0 128.0 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,286 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.50 stddev:5.49 (3.8%) stddev-sans-first:5.70 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: Values: 140.0 146.0 137.0 145.0 147.0 150.0 145.0 149.0 140.0 133.0 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:2.01 (2.8%) stddev-sans-first:2.13 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 69.0 73.0 69.0 74.0 71.0 75.0 71.0 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:12 INFO - 2015-11-13 08:44:12,287 DEBUG : BROWSER_OUTPUT: 08:44:13 INFO - 2015-11-13 08:44:13,201 INFO : Browser exited with error code: 0 08:44:13 INFO - 2015-11-13 08:44:13,255 INFO : Completed test kraken (00:01:02) 08:44:13 INFO - 2015-11-13 08:44:13,255 INFO : Starting test v8_7 08:44:13 INFO - 2015-11-13 08:44:13,255 DEBUG : operating with platform_type : linux_ 08:44:13 INFO - 2015-11-13 08:44:13,255 INFO : Initialising browser for v8_7 test... 08:44:13 INFO - 2015-11-13 08:44:13,261 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzjwD3w/profile http://localhost:45548/getInfo.html 08:44:18 INFO - 2015-11-13 08:44:18,691 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:44:18 INFO - 2015-11-13 08:44:18,691 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:44:18 INFO - 2015-11-13 08:44:18,691 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:44:18 INFO - 2015-11-13 08:44:18,691 DEBUG : BROWSER_OUTPUT: __metrics 08:44:19 INFO - 2015-11-13 08:44:19,881 INFO : Browser initialized. 08:44:19 INFO - 2015-11-13 08:44:19,882 INFO : Running cycle 1/1 for v8_7 test... 08:44:19 INFO - 2015-11-13 08:44:19,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzjwD3w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:44:31 INFO - 2015-11-13 08:44:31,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 141246464 08:44:31 INFO - 2015-11-13 08:44:31,803 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45548/tests/v8_7/run.html (next: http://localhost:45548/tests/v8_7/run.html) 08:44:53 INFO - 2015-11-13 08:44:53,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 137011200 08:44:53 INFO - 2015-11-13 08:44:53,611 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:53 INFO - 2015-11-13 08:44:53,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: |0;Richards;164.69038208168644 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.25056775170324 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 08:44:53 INFO - 2015-11-13 08:44:53,612 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 08:44:53 INFO - 2015-11-13 08:44:53,613 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1057.0824524312895 08:44:53 INFO - 2015-11-13 08:44:53,613 DEBUG : BROWSER_OUTPUT: |5;Earley;736.3770250368188 08:44:53 INFO - 2015-11-13 08:44:53,613 DEBUG : BROWSER_OUTPUT: |6;Boyer;12518.518518518518 08:44:53 INFO - 2015-11-13 08:44:53,613 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 08:44:53 INFO - 2015-11-13 08:44:53,613 DEBUG : BROWSER_OUTPUT: |8;Splay;611.6207951070336 08:44:53 INFO - 2015-11-13 08:44:53,614 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:44:53 INFO - 2015-11-13 08:44:53,614 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:53 INFO - 2015-11-13 08:44:53,614 DEBUG : BROWSER_OUTPUT: __startTimestamp1447433093609__endTimestamp 08:44:53 INFO - 2015-11-13 08:44:53,614 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,614 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.69 Median:164.69 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: Values: 164.7 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,615 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.25 Median:189.25 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,616 DEBUG : BROWSER_OUTPUT: Values: 189.3 08:44:53 INFO - 2015-11-13 08:44:53,616 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,616 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,616 DEBUG : BROWSER_OUTPUT: Values: 280.4 08:44:53 INFO - 2015-11-13 08:44:53,616 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,617 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,617 DEBUG : BROWSER_OUTPUT: Values: 5060.6 08:44:53 INFO - 2015-11-13 08:44:53,617 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,617 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,617 DEBUG : BROWSER_OUTPUT: Values: 1057.1 08:44:53 INFO - 2015-11-13 08:44:53,618 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,618 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.38 Median:736.38 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,618 DEBUG : BROWSER_OUTPUT: Values: 736.4 08:44:53 INFO - 2015-11-13 08:44:53,618 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,618 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12518.52 Median:12518.52 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: Values: 12518.5 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: Values: 25923.1 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.62 Median:611.62 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,619 DEBUG : BROWSER_OUTPUT: Values: 611.6 08:44:53 INFO - 2015-11-13 08:44:53,620 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-11-13 08:44:53,620 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-11-13 08:44:53,620 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:44:53 INFO - 2015-11-13 08:44:53,620 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:53 INFO - 2015-11-13 08:44:53,620 DEBUG : BROWSER_OUTPUT: 08:44:54 INFO - 2015-11-13 08:44:54,521 INFO : Browser exited with error code: 0 08:44:54 INFO - 2015-11-13 08:44:54,534 INFO : Completed test v8_7 (00:00:41) 08:44:54 INFO - 2015-11-13 08:44:54,563 INFO : Completed test suite (00:20:19) 08:44:54 INFO - 2015-11-13 08:44:54,563 DEBUG : Working with test: dromaeo_css 08:44:54 INFO - 2015-11-13 08:44:54,563 DEBUG : Generating results file: dromaeo_css 08:44:54 INFO - 2015-11-13 08:44:54,564 DEBUG : Working with test: kraken 08:44:54 INFO - 2015-11-13 08:44:54,565 DEBUG : Generating results file: kraken 08:44:54 INFO - 2015-11-13 08:44:54,565 INFO : javascript benchmark 08:44:54 INFO - 2015-11-13 08:44:54,565 DEBUG : Working with test: v8_7 08:44:54 INFO - 2015-11-13 08:44:54,565 DEBUG : Generating results file: v8_7 08:44:54 INFO - 2015-11-13 08:44:54,565 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-11-13 08:44:54,621 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 08:44:54 INFO - 2015-11-13 08:44:54,621 DEBUG : process_Request line: dromaeo_css 6020.84 graph.html#tests=[[72,131,43]] 08:44:54 INFO - 2015-11-13 08:44:54,621 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-11-13 08:44:54,659 DEBUG : process_Request line: kraken 1533.40 graph.html#tests=[[232,131,43]] 08:44:54 INFO - 2015-11-13 08:44:54,659 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-11-13 08:44:54,694 DEBUG : process_Request line: v8_7 21262.61 graph.html#tests=[[230,131,43]] 08:44:54 INFO - 2015-11-13 08:44:54,696 INFO : javascript benchmark 08:44:54 INFO - 2015-11-13 08:44:54,700 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [327.41229493059956, 328.74358000759406, 328.89310973933465, 336.1445122164092, 336.34077208671005, 10770.569177232901, 11067.280626759255, 14950.10299382038, 15454.768178477332, 15513.92243038786, 10381.377117372964, 10593.629222977197, 10711.0, 10732.678019659403, 10752.78494430111, 4057.6348128668487, 4160.2303573838935, 4165.979170104145, 4174.791260436981, 4177.12280421112, 4058.594140585947, 4114.8148333324925, 4134.813933373005, 4139.379093136024, 4186.958130418702, 4097.385392191165, 4100.36444351126, 4401.36180253863, 4516.41286632739, 4521.841735539257, 4486.439195100596, 4505.797239124247, 4508.278675411935, 4521.412216411878, 4530.70550414222, 3827.674647654953, 3900.161465284949, 3918.3338832398563, 3928.489296391451, 3943.98028009861, 11960.102992275613, 12123.151379403445, 12151.088668349821, 12265.938670306681, 12266.509339626404, 1678.9160541972853, 1704.2330951071942, 1714.545645403969, 1741.4949664597252, 1754.1843042984945, 9022.954885225598, 9041.77395565116, 9276.211522020636, 9292.814143717156, 9441.0, 1587.5078725594988, 1609.2758258783595, 1609.452786052736, 1637.8280280570489, 1662.1356894414957, 52380.21429678596, 52792.208116878275, 53696.463035369925, 54207.0, 54920.72539637276, 6293.527985401021, 6376.182787905424, 6381.649009304533, 6397.168368112116, 6426.967865160737, 7499.700011999459, 7506.099268087864, 7507.8498430031095, 7511.51175173612, 7546.886796698054, 4976.5023497649945, 4989.451160372356, 4995.550400463903, 5023.070731914608, 5042.520960508746, 4933.383327084114, 5003.249512573143, 5006.249062640633, 5014.0, 5033.79864805411, 2957.216337670519, 2972.539256415259, 2977.35986762847, 2982.120274519022, 2986.4027194561177, 1044.3525014491065, 1044.9007344302279, 1049.459528342904, 1060.6764936694383, 1107.7618312062784, 386.53808698605457, 388.5919784226607, 391.74928046050553, 404.6701937920585, 428.8670512141246, 9220.7694807629, 9410.0, 9559.94840567537, 9694.951525242328, 9893.109620134079, 372.44877581180003, 382.2622338885921, 390.7069697726705, 393.227308339115, 403.38282427885383, 5247.553957913544, 5261.2641426458795, 5272.789088436496, 5295.814646487354, 5394.91907621386, 467484.0, 470788.0, 471137.0, 473503.0, 473634.0, 66224.66887665627, 69811.65094174497, 70263.0, 72021.27978720251, 72102.0, 461.40478782371036, 464.03943836259293, 467.67262915958963, 469.5023275328163, 473.8602112376857, 10199.184065274612, 10212.693619191436, 10230.386176829414, 10301.175905927657, 10374.533146008598, 32524.349513010082, 33526.0, 33683.494747579294, 33986.32027359489, 34477.65522344845, 40579.79710101431, 41879.37180942227, 45635.0, 46304.768476157406, 47057.0, 5959.22530071088, 6142.9078563820685, 6144.907826382697, 6145.477634400947, 6158.938410615837, 10067.446290454096, 10399.48002599882, 10406.895931040593, 10563.577456901638, 10607.734806629896, 7849.411294152847, 9066.0, 9084.000759916536, 9186.54067296646, 9660.033996600283, 8895.332850036144, 9204.355695101278, 9406.38858474197, 9491.762705932408, 9643.0, 9485.478298693639, 9537.284703647116, 9708.708738737849, 9723.805523889341, 9808.950955245178, 6103.267607887082, 6104.816855494342, 6117.357677443804, 6127.754889804358, 6137.140800287874, 9347.065293470598, 9492.335536512377, 9664.130228279208, 9746.9025309746, 9798.706038818847], "dojo.html": [2681.932951676209, 2682.785377169826, 2712.56598944169, 2716.687580928193, 2736.384313529456, 4557.248054071082, 4665.370175026374, 4698.976505117478, 4723.126221648993, 4805.159097157996, 4612.054528821592, 4655.348251244828, 4742.146413645542, 4745.335653008581, 4755.286706993953, 4367.519572846984, 4399.494058183318, 4400.537943515933, 4403.361512580674, 4427.2695005324085, 4422.137683151786, 4430.911381772363, 4497.730136191839, 4501.122281155176, 4538.455385353745, 4188.811503482335, 4267.231898258312, 4290.077633308853, 4410.3825464435, 4419.359192917042, 4378.0, 4388.670849686287, 4396.736195828261, 4444.6666500012625, 4455.777211139462, 4194.958050419487, 4322.913541729179, 4369.060651959812, 4405.22908491016, 4427.490838553543, 4606.631469482433, 4675.064987002613, 4771.28430735389, 4804.519548045202, 4819.156647586658, 5049.899002019939, 5067.265246539231, 5073.264376665363, 5089.211172268304, 5099.872503187413, 4905.975470122662, 5027.84916452507, 5121.897562048775, 5128.666636668642, 5149.45930677281, 4712.952870471286, 4772.117158325721, 4781.545753153445, 4796.328514008042, 4842.58837998774, 5228.581713462914, 5237.895242095136, 5259.368875734936, 5260.237265596544, 5276.261323414725, 4858.271259311132, 4940.2342636891335, 4964.627652926045, 5034.320366750515, 5048.697078175322, 5160.432352441228, 5166.0, 5172.8965420691375, 5187.559057480156, 5222.1383471727495, 5098.388193416814, 5102.413222479388, 5110.029094472038, 5113.207452844815, 5155.123628983082, 4791.976040119846, 4888.071266459361, 4973.403191617029, 5068.062408454448, 5086.745662716849, 4253.744775313429, 4256.021115143534, 4266.807993640294, 4271.444712187458, 4280.443542339476, 3771.5474143103, 3774.150816066363, 3774.471573979645, 3778.848846046127, 3780.5652349980105, 4314.1371725655, 4359.585839345257, 4398.252297109499, 4419.845305414359, 4432.224360736858, 5084.33903592538, 5103.260027296022, 5117.744112794346, 5148.124818780816, 5162.432132465426, 4196.391523229115, 4395.099004704028, 4397.9560204398185, 4431.556844315607, 4434.246178149658, 4431.645468362523, 4486.0, 4553.635709143261, 4567.794449249792, 4599.1721490132095, 4851.95148048515, 4880.170371036932, 4892.584130348889, 4939.357883475125, 4964.900701986012, 4937.333459982857, 5167.689938603696, 5202.609804264771, 5204.661696989683, 5245.947540524546, 4665.976670116627, 4706.552877476634, 4726.26742854858, 4755.595774359218, 4760.833370832004, 5052.216906379517, 5109.6678715883345, 5128.487151284991, 5129.102407078821, 5180.818671346636, 4849.75751212445, 4967.751612419437, 5164.122099243063, 5179.585633149414, 5184.533391994739, 4840.927386089141, 4891.730954797378, 4921.581665558468, 4926.433460151985, 4978.153713868724, 4959.876003099807, 4994.550490455877, 5016.623753218596, 5039.647224694236, 5041.798328066836, 4677.181493238738, 4742.004179122285, 4803.063402636452, 4931.334269873521, 4977.178765503651, 4962.280469331855, 4966.453690094015, 4971.850844474671, 4993.725345106054, 5034.823781167642, 4838.516148385133, 4846.5638092571835, 4853.466118727008, 4869.0, 4883.511648835088], "mootools.html": [1466.9438004636659, 1629.2179753718215, 1652.719037763581, 1681.445123109374, 1704.2671651189987, 6659.533832631718, 6775.254721980578, 6866.622335771531, 6956.965215173924, 6976.1628604567395, 7118.822029449267, 7152.713891444336, 7171.390431813289, 7199.964000179992, 7207.0630817993715, 1992.8306093981992, 2027.9391618251475, 2043.56063446359, 2048.2831009146753, 2057.86623869448, 1992.1135094882784, 2038.6228547718645, 2039.0212697905015, 2054.6096241714026, 2065.8863762493056, 1915.7126431035385, 1965.9606807863834, 1969.3599580136513, 2020.8686435381726, 2044.1516770540209, 2002.1991203518564, 2005.2780998840406, 2006.3379084901946, 2027.888466134362, 2035.7964203579672, 1984.4344361856945, 2010.9296174633964, 2011.4267433781301, 2034.08466190215, 2038.6330460517102, 6922.5154239203275, 7050.5769653820425, 7063.964680176567, 7066.0814094167945, 7085.858282834366, 4041.211963667086, 4086.9182616347507, 4092.897677558085, 4101.179764047172, 4122.196171746511, 2630.013744845683, 2659.521286168489, 2705.4318593095472, 2709.7967652426146, 2728.2224565998595, 811.8335741173105, 811.9431639785217, 818.3453237410048, 829.1666874790857, 862.6894318045498, 9431.198348140417, 9459.858102128474, 9469.763255918588, 9505.952470237673, 9560.76098097553, 3725.869594564177, 3781.470594116826, 3810.0855794609092, 3819.751716138442, 3819.9045023874623, 7833.725819596287, 7850.489718168301, 7856.921430785734, 7865.292123708894, 7898.684052637945, 4213.094184750294, 4242.44848169736, 4252.936205956913, 4260.872173834728, 4268.274393353137, 3866.4393662919283, 3866.613338666111, 3911.2568611963634, 3917.1578110706337, 3926.018495376156, 3097.7212050915527, 3137.2470607054142, 3148.937021259562, 3163.636181839072, 3172.8730850766174, 882.8366752150872, 899.9910000900038, 912.1790388650135, 914.1772404835568, 915.9267258619294, 818.0960039156765, 869.852125138728, 875.0461996423801, 946.2619157057507, 971.4754032822339, 6533.18335208099, 6550.0, 6566.0, 6607.933920660732, 6639.502037347122, 1024.9795004099876, 1027.5735569738624, 1051.5846240734868, 1068.9251752377415, 1076.4025965589174, 5354.357477102694, 5368.3826359968325, 5372.435894231049, 5399.946000540023, 5404.8108316208745, 8233.711820086268, 8268.173182681803, 8420.115887831813, 8447.239748422671, 8456.534890581077, 8321.876546666244, 8333.125021872738, 8337.666493340319, 8349.707760228363, 8371.874421883676, 6511.609303441714, 6656.70044847983, 6734.797956061326, 6755.493337999571, 6782.762603308861, 6642.933570664231, 6650.90023649636, 6705.09481220029, 6708.731650733916, 6762.695678694372, 7437.330640242404, 7519.699212031457, 7574.356179724785, 7675.654595543102, 7693.4614576979075, 7505.399568034435, 7619.428542859197, 7766.262205090507, 7780.533168009937, 7855.057393112863, 6145.600535965148, 6146.108814222002, 6182.196314479089, 6212.658303793335, 6231.626102433868, 6683.9331606685255, 6684.4318232950745, 6717.529772915849, 6722.529422940347, 6824.965875170592, 6312.589681670676, 6389.201349831271, 6399.136116624382, 6469.5794773339585, 6578.703958321791, 5458.972705136449, 6327.96836015817, 6340.619562826245, 6341.49268058545, 6447.4197322241225, 6465.22417309907, 6471.708773105316, 6481.837954051187, 6484.967575162283, 6494.675266236574, 5866.061430171152, 5902.439268269508, 5917.349091600006, 5922.0, 5924.081767326072, 6012.278526576839, 6037.335893051673, 6057.575969682256, 6068.271807383142, 6071.817845464643], "ext.html": [524.6484855147052, 555.9416261292566, 581.531866847188, 583.8978178818709, 586.3667239381468, 28464.15733875926, 36950.445743313874, 37272.76363418193, 37575.436368454495, 37717.62282377175, 39837.20325593494, 40438.0, 40483.19033619326, 40560.79719601398, 40645.0, 7853.450258481908, 8036.4776289541, 8045.275925166734, 8045.6781728731075, 8053.879191812128, 7941.32498737608, 7986.1614530474335, 7994.680212791482, 8005.959970200141, 8055.63749631268, 7944.960275198616, 8020.197980201991, 8048.959755201216, 8098.554579498125, 8106.229908158715, 7933.048034235871, 7944.523328600302, 7959.243871832166, 7970.0, 8024.67901283948, 7768.7669369918995, 7882.132965373804, 7886.960565197194, 7903.328217101496, 7908.9604551977445, 36949.63050369489, 37276.44085338722, 37441.81279093587, 37477.437838432445, 37503.0, 2801.6918139004897, 2897.3046468847538, 2915.6355455568055, 2991.8055326403933, 3026.8486575671127, 27628.30929226765, 27807.443851122865, 27854.5821812673, 28334.14997550056, 28397.432051359065, 2613.451175253199, 2629.250663560876, 2652.82756620819, 2691.327168207948, 2728.7953403494816, 219972.0, 222769.0, 223055.0, 223400.0, 224317.14889978772, 51627.0, 52614.21078683823, 56132.438675613535, 63444.0, 63975.0, 56226.43773562212, 56521.71739141278, 56732.0, 56819.715901420226, 56866.43133568612, 12667.556635517896, 12730.23618582888, 12749.553765618159, 12756.425960831784, 12766.744665106646, 10489.47552622381, 10545.9472702636, 10561.155107591374, 10577.471126443646, 10583.788324233472, 19215.231390744495, 19334.049409237436, 19428.971098843227, 19640.70538941917, 19694.803051969582, 7867.173946735625, 7919.20807919215, 8004.879926801103, 8006.559639219782, 8056.126043743568, 854.5641722721457, 906.419891269588, 940.8071345374182, 944.8393773058597, 1031.128696251681, 26197.607035894478, 30030.549541756893, 30685.0, 31000.22499437532, 31070.0, 953.1516949914582, 954.5609019850947, 963.4749061761357, 1050.8791488978713, 1103.4648195625116, 12780.808287875689, 13413.195208287534, 13556.45774169042, 13607.11553749023, 13627.863721362857, 309106.0, 311902.0, 312546.0, 312834.0, 314217.0, 46549.534504655196, 47225.05549888983, 47334.0, 47390.76304618455, 47400.7629961848, 1200.5137919142762, 1205.4635687119148, 1206.6561030106377, 1210.527894121311, 1212.0545974140184, 24930.50138997246, 25185.49629007373, 25329.0, 25405.0, 25480.23559293224, 35549.82225088858, 36681.0, 36698.0, 36811.26377472489, 36847.815760921025, 242119.0, 243162.0, 244012.0, 245417.0, 246081.0, 29219.123426297247, 41762.791186043876, 43219.78390108029, 43887.12225755403, 43960.0, 39825.40261896132, 40098.79950600345, 40194.1961160781, 40939.0, 41267.174656506104, 34156.82921585376, 34462.28632904315, 34466.10436426021, 34605.13487162841, 35318.117047074025, 34662.480062798575, 34821.0, 34899.0, 34917.650823491436, 35091.82454087815, 34157.31685366329, 34518.82740586281, 34522.0, 34740.652593474755, 34852.47721284132, 30117.3976520464, 31162.0, 31281.374372512877, 31435.685643143275, 31460.213494662818, 24124.638130427706, 24377.756222438256, 24549.263522094367, 24641.876790615934, 24676.0], "prototype.html": [281.42027423507574, 286.0731230812168, 291.9708029197079, 291.99708002919976, 295.96448426188863, 5508.0, 5647.322321321442, 5728.770849166029, 5733.111367738002, 5841.941580584204, 5686.5735069869825, 5687.345955215152, 5696.6866822324755, 5698.772049118041, 5709.914351284734, 4306.655467562603, 4324.82700691972, 4325.740455572668, 4342.478902531685, 4343.913121737563, 4315.805788739499, 4324.502682191557, 4333.588309110645, 4343.6959412841115, 4343.9348409773875, 4200.138971510848, 4256.765877876715, 4268.103698223361, 4275.636570891463, 4281.807318670667, 4262.25410553152, 4268.893277668052, 4276.102018576072, 4278.893027674333, 4284.378765079077, 3675.3016926784094, 3695.4087346024776, 3701.722370822199, 3702.0559757261994, 3705.6479634434686, 5457.727113644302, 5467.480589344006, 5472.91790623141, 5474.589405794582, 5477.835664930059, 4649.814007439699, 4814.879628009293, 4921.803127874917, 4926.2118061110405, 4950.034743225073, 5720.542356611461, 5898.557608179403, 5904.114382842565, 5912.201852749867, 5928.318243401977, 3910.765354078736, 3918.1967696622123, 3928.332183528807, 3932.370820668708, 3951.980240098781, 6154.815355539341, 6241.0, 6256.280527739323, 6268.122462855204, 6270.561060725706, 3969.4244334571326, 4023.1350259693722, 4024.91950161001, 4050.210209009274, 4056.1887622475624, 4112.115895082572, 4123.690723195772, 4133.152703695735, 4133.23535145999, 4139.2135494256, 4800.375951126401, 4808.374911261513, 4817.397825271841, 4823.2282834746975, 4825.131476334223, 5900.1739756434135, 5909.113632955005, 5915.0, 5926.614770039933, 5934.851628709317, 1406.1773862290675, 1431.77807439847, 1454.1711224602086, 1464.348364977596, 1465.7947887295786, 944.3342443577261, 951.7049714588361, 955.1737746848926, 966.21253678252, 967.6516454076527, 5038.672486288379, 5047.772850221749, 5063.1898896176435, 5064.5441910228255, 5094.5160209780015, 6038.275406951194, 6048.788292409832, 6055.969720151459, 6068.878622427526, 6080.2399700037495, 5024.422191447957, 5042.773075211624, 5061.468545802712, 5065.936153407752, 5066.620003499678, 3227.064151396069, 3281.4585593376823, 3288.917777055593, 3294.7364210863075, 3300.9834950825093, 5608.523275521545, 5649.491545760901, 5652.406497317723, 5666.518345940642, 5667.858303542444, 6226.128342032119, 6236.126942228092, 6237.09562113491, 6237.844053898689, 6245.0632405139595, 5667.348254950651, 5670.5747068969995, 5678.233438485834, 5877.794277200277, 5883.058710606282, 6198.380161983946, 6220.129181914626, 6243.687815609293, 6252.656103914146, 6254.249490061222, 6019.578629495893, 6028.3971602839365, 6055.455009049207, 6076.088586711851, 6078.878422431439, 5646.576506761927, 5791.378414044075, 5845.8538536535225, 5846.1815345852465, 5862.765489380377, 4018.0557568971853, 4055.270051390778, 4056.046828995243, 4066.776327302027, 4076.062505623664, 6254.405831446005, 6267.62394256346, 6274.466670333073, 6275.592086514362, 6284.371562843679, 5959.940400595939, 6004.339522652592, 6006.3693312201585, 6015.608985415934, 6017.338092809875, 5784.161296612052, 5985.162077309094, 5985.431384018511, 5989.460948514655, 6016.187814644967, 5829.446202610915, 5868.970655146697, 5884.558658100574, 5888.263967004124, 5893.941060589339, 5971.940280597139, 6029.969850150721, 6039.818805435844, 6042.848928776816, 6076.331603523698, 5721.141828725558, 5817.534597232296, 5821.068629019336, 5853.590248682552, 5862.413758624103], "yui.html": [776.157868712447, 780.9882851757225, 783.7609529093626, 793.4921650143913, 794.936405087593, 11929.343886086273, 12119.030477561795, 12201.0, 12202.267863928171, 12225.633231003074, 11802.940985295061, 12077.214981026249, 12138.0, 12146.453409596566, 12201.572944946929, 777.9922200777991, 781.4607920534813, 794.0590400375545, 795.1769918134731, 795.5226863881683, 788.7239466186846, 792.3977776889548, 793.4763056382789, 795.8288967871906, 796.7848680856165, 827.9130691277419, 836.9414141010132, 838.3502785341378, 839.4375768235267, 840.315143158324, 826.8057006603443, 831.9292860106838, 832.1927730101792, 833.1793183714037, 834.862247729124, 612.1613389656155, 612.457974692396, 613.2640831002769, 614.5452365249728, 615.5691016288616, 11947.880521194764, 11956.043516518657, 11987.0, 12003.399830008464, 12022.63932082039, 11622.360770157638, 11696.122790790725, 11735.178537502377, 11962.461689224006, 12028.699282518008, 9059.271396959457, 9293.674721384787, 9339.719808405758, 9503.619855205852, 9579.856302155473, 2898.3623602807347, 2900.2459360566404, 2938.823670579772, 2947.8083924544835, 3000.009996701105, 36702.449463258075, 37186.628133718856, 37234.25531489355, 37336.0, 37393.25213495742, 6414.294427612959, 6648.933510664831, 6772.11962444879, 6867.278935711778, 6873.748892053655, 10400.219983501116, 10515.684529464128, 10519.421431821323, 10530.578776848994, 10600.204984626183, 5748.425157484218, 5909.261342332208, 5962.07587823888, 6036.8188954331445, 6040.973034584131, 3679.0986208379118, 3781.1870447853844, 3809.4857194278416, 3827.2154208387215, 3827.6363745444137, 2435.4033261850605, 2448.1186772761794, 2461.0524947895187, 2465.6671349367966, 2481.1440053181623, 383.5914750790399, 384.45983393332415, 387.8157875009348, 388.3921662598025, 389.6240128276227, 437.531840930208, 438.4610018833916, 445.8105305245323, 449.5841346754239, 486.6885193476178, 7630.923690763021, 7747.418943579141, 8016.238457346542, 8317.584120793936, 8711.259542938795, 481.71097341595464, 486.45167682171416, 545.3673738463364, 596.7165596341703, 636.8567072408764, 3727.2731817295366, 3736.308782875177, 3742.2328422673286, 3752.1745216052423, 3827.158025234444, 54745.0, 55223.0, 55806.44193558094, 55918.16122758162, 56400.71799640975, 40798.0, 44962.77518612451, 47090.5290947093, 49676.50323496719, 49876.25185622219, 43194.13611727748, 43530.7823460887, 44425.0, 44846.103077938256, 45027.77486112614, 8119.0, 8154.633041513028, 8185.30424913889, 8440.198181172778, 8501.447405918596, 30521.08436746901, 30754.846225768728, 31340.865913408477, 33483.0, 33759.98720038403, 39608.40587391249, 42379.576204238794, 42919.356209657504, 43205.0, 43355.0, 6599.637019963948, 6607.834804129935, 6799.864002719819, 6875.7937261882225, 7080.610566418896, 11078.0, 11230.213885028297, 11278.436078196222, 11301.547938082385, 11489.770204596029, 10676.14590832716, 10762.246642734934, 10839.67480975572, 11089.500972456097, 11200.607978720705, 10356.275060745977, 10508.422036787744, 10534.525946332587, 10559.260851740304, 10648.84026739584, 10790.460476975963, 10800.567977280822, 10801.081908037904, 10865.891341086488, 10906.236563440483, 9184.448933064037, 9340.626374945197, 9448.905510945078, 9690.56392462355, 9741.123298902849, 8747.212750852454, 8942.73171804847, 8946.552672366486, 9201.723948281562, 9205.677801276923]}, "summary": {"lowerIsBetter": false, "suite": 6020.840580521069, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6130.144750420824, "unit": "ms", "value": 6130.144750420824}, "dojo.html": {"lowerIsBetter": false, "filtered": 4672.035527510732, "unit": "ms", "value": 4672.035527510732}, "mootools.html": {"lowerIsBetter": false, "filtered": 4012.8734564878982, "unit": "ms", "value": 4012.8734564878982}, "ext.html": {"lowerIsBetter": false, "filtered": 17118.845911500426, "unit": "ms", "value": 17118.845911500426}, "prototype.html": {"lowerIsBetter": false, "filtered": 4381.211983653631, "unit": "ms", "value": 4381.211983653631}, "yui.html": {"lowerIsBetter": false, "filtered": 5525.853609940861, "unit": "ms", "value": 5525.853609940861}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447431875, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 166.0, 164.0, 163.0, 162.0, 166.0, 166.0, 164.0, 164.0, 162.0], "ai-astar": [113.0, 109.0, 113.0, 113.0, 114.0, 123.0, 111.0, 112.0, 112.0, 114.0], "imaging-gaussian-blur": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 109.0], "audio-beat-detection": [157.0, 139.0, 157.0, 166.0, 134.0, 160.0, 158.0, 132.0, 169.0, 132.0], "json-stringify-tinderbox": [66.0, 67.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [140.0, 146.0, 137.0, 145.0, 147.0, 150.0, 145.0, 149.0, 140.0, 133.0], "json-parse-financial": [74.0, 73.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 76.0, 72.0], "stanford-crypto-sha256-iterative": [71.0, 70.0, 71.0, 69.0, 73.0, 69.0, 74.0, 71.0, 75.0, 71.0], "audio-fft": [74.0, 75.0, 73.0, 78.0, 77.0, 133.0, 74.0, 72.0, 73.0, 73.0], "imaging-darkroom": [150.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0], "stanford-crypto-ccm": [123.0, 122.0, 125.0, 133.0, 122.0, 125.0, 128.0, 129.0, 129.0, 128.0], "audio-oscillator": [92.0, 91.0, 127.0, 93.0, 91.0, 93.0, 135.0, 94.0, 93.0, 132.0], "stanford-crypto-aes": [83.0, 84.0, 85.0, 87.0, 88.0, 84.0, 84.0, 87.0, 86.0, 87.0], "imaging-desaturate": [96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1533.4000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.2, "unit": "ms", "value": 143.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.4, "unit": "ms", "value": 150.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.4, "unit": "ms", "value": 126.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.7, "unit": "ms", "value": 147.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.0, "unit": "ms", "value": 74.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.4, "unit": "ms", "value": 113.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.0, "unit": "ms", "value": 164.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.4, "unit": "ms", "value": 71.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.2, "unit": "ms", "value": 110.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.5, "unit": "ms", "value": 85.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.2, "unit": "ms", "value": 96.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447431875, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [189.25056775170324], "Encrypt": [280.42624789680315], "NavierStokes": [4830.917874396136], "Decrypt": [5060.606060606061], "Splay": [611.6207951070336], "Richards": [164.69038208168644], "RegExp": [25923.076923076922], "Earley": [736.3770250368188], "Boyer": [12518.518518518518], "RayTrace": [1057.0824524312895]}, "summary": {"lowerIsBetter": false, "suite": 21262.611506425914, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 349.36751200000015, "unit": "score", "value": 349.36751200000015}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.2014460000001, "unit": "score", "value": 949.2014460000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.59864071856286, "unit": "score", "value": 52.59864071856286}, "Splay": {"lowerIsBetter": false, "filtered": 133.23778500000006, "unit": "score", "value": 133.23778500000006}, "RegExp": {"lowerIsBetter": false, "filtered": 35.14185459940652, "unit": "score", "value": 35.14185459940652}, "Richards": {"lowerIsBetter": false, "filtered": 214.35374400000003, "unit": "score", "value": 214.35374400000003}, "Earley": {"lowerIsBetter": false, "filtered": 905.0567539999997, "unit": "score", "value": 905.0567539999997}, "Boyer": {"lowerIsBetter": false, "filtered": 53.238168639053214, "unit": "score", "value": 53.238168639053214}, "RayTrace": {"lowerIsBetter": false, "filtered": 700.0295939999999, "unit": "score", "value": 700.0295939999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-038.e"}, "testrun": {"date": 1447431875, "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": "20151113072730", "branch": "Mozilla-Inbound-Non-PGO", "revision": "97e1e855ec9ae5776ce04919f0da1d650d4f410f"}}] 08:44:54 INFO - RETURN: dromaeo_css: 6020.84 08:44:54 INFO - RETURN: kraken: 1533.40 08:44:54 INFO - RETURN: v8_7: 21262.61 08:44:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21262.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1533.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6020.84"}}} 08:44:54 INFO - Return code: 0 08:44:54 INFO - # TBPL SUCCESS # 08:44:54 INFO - Running post-action listener: _resource_record_post_action 08:44:54 INFO - Running post-run listener: _resource_record_post_run 08:44:55 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 499695616; Read time: 0; Write time: 630504 08:44:55 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 152387584; Read time: 0; Write time: 217756 08:44:55 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 276639744; Read time: 0; Write time: 228868 08:44:55 INFO - Running post-run listener: _upload_blobber_files 08:44:55 INFO - Blob upload gear active. 08:44:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:44:55 INFO - Copying logs to upload dir... 08:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.120713 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-13 08:44:55.626567) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:44:55.630311) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009907 build_url: 'https://queue.taskcluster.net/v1/task/wqaN_13ESnelH8GXU4RiEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 08:44:55.682818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:44:55.683267) ========= 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=e8c3f5a4c0a512351e80f2ca000001d7-1447431827.29809-1902827431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 08:44:55.736160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:44:55.736570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 08:44:55.736942) ========= ========= Total master_lag: 4.32 =========