builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1447332109.24 results: success (0) buildid: 20151112025847 builduid: b706f9cffc5943ecaea63184f82f66f7 revision: 662a3871dc77c9fe85abbaba483c5537ce94100b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.244892) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.245289) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.245570) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006481 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.269997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.270283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.329107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.329406) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.388662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.388923) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.389279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.389561) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 04:41:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-12 04:41:51 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.572889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.573201) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019382 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.630983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:49.631535) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 662a3871dc77c9fe85abbaba483c5537ce94100b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 662a3871dc77c9fe85abbaba483c5537ce94100b --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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 04:41:51,156 truncating revision to first 12 chars 2015-11-12 04:41:51,156 Setting DEBUG logging. 2015-11-12 04:41:51,156 attempt 1/10 2015-11-12 04:41:51,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/662a3871dc77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 04:41:51,400 unpacking tar archive at: mozilla-central-662a3871dc77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:50.160489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:50.160785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:50.171269) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:50.171566) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:41:50.171956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-12 04:41:50.172255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:51 INFO - MultiFileLogger online at 20151112 04:41:51 in /builds/slave/test 04:41:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:41:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:51 INFO - {'append_to_log': False, 04:41:51 INFO - 'base_work_dir': '/builds/slave/test', 04:41:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:41:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:51 INFO - 'branch': 'Firefox-Non-PGO', 04:41:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:51 INFO - 'config_files': ('talos/linux_config.py',), 04:41:51 INFO - 'default_actions': ('clobber', 04:41:51 INFO - 'read-buildbot-config', 04:41:51 INFO - 'download-and-extract', 04:41:51 INFO - 'populate-webroot', 04:41:51 INFO - 'create-virtualenv', 04:41:51 INFO - 'install', 04:41:51 INFO - 'run-tests'), 04:41:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:51 INFO - 'download_minidump_stackwalk': True, 04:41:51 INFO - 'download_symbols': 'ondemand', 04:41:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:51 INFO - 'installer_path': 'installer.exe', 04:41:51 INFO - 'log_level': 'info', 04:41:51 INFO - 'log_name': 'talos', 04:41:51 INFO - 'log_to_console': True, 04:41:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:51 INFO - 'opt_config_files': (), 04:41:51 INFO - 'pip_index': False, 04:41:51 INFO - 'sps_profile': False, 04:41:51 INFO - 'sps_profile_interval': 0, 04:41:51 INFO - 'suite': 'dromaeojs', 04:41:51 INFO - 'system_bits': '64', 04:41:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:51 INFO - 'title': 'talos-linux64-ix-039', 04:41:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:51 INFO - 'use_talos_json': True, 04:41:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:51 INFO - 'work_dir': 'build'} 04:41:51 INFO - ##### 04:41:51 INFO - ##### Running clobber step. 04:41:51 INFO - ##### 04:41:51 INFO - Running pre-action listener: _resource_record_pre_action 04:41:51 INFO - Running main action method: clobber 04:41:51 INFO - rmtree: /builds/slave/test/build 04:41:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:52 INFO - Running post-action listener: _resource_record_post_action 04:41:52 INFO - ##### 04:41:52 INFO - ##### Running read-buildbot-config step. 04:41:52 INFO - ##### 04:41:52 INFO - Running pre-action listener: _resource_record_pre_action 04:41:52 INFO - Running main action method: read_buildbot_config 04:41:52 INFO - Using buildbot properties: 04:41:52 INFO - { 04:41:52 INFO - "properties": { 04:41:52 INFO - "buildnumber": 210, 04:41:52 INFO - "product": "firefox", 04:41:52 INFO - "script_repo_revision": "production", 04:41:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:41:52 INFO - "repository": "", 04:41:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:41:52 INFO - "buildid": "20151112025847", 04:41:52 INFO - "slavename": "talos-linux64-ix-039", 04:41:52 INFO - "pgo_build": "False", 04:41:52 INFO - "basedir": "/builds/slave/test", 04:41:52 INFO - "project": "", 04:41:52 INFO - "platform": "ubuntu64_hw", 04:41:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:41:52 INFO - "slavebuilddir": "test", 04:41:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:41:52 INFO - "branch": "mozilla-central", 04:41:52 INFO - "repo_path": "mozilla-central", 04:41:52 INFO - "stage_platform": "linux64", 04:41:52 INFO - "builduid": "b706f9cffc5943ecaea63184f82f66f7", 04:41:52 INFO - "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b" 04:41:52 INFO - }, 04:41:52 INFO - "sourcestamp": { 04:41:52 INFO - "repository": "", 04:41:52 INFO - "hasPatch": false, 04:41:52 INFO - "project": "", 04:41:52 INFO - "branch": "mozilla-central-linux64-talos", 04:41:52 INFO - "changes": [ 04:41:52 INFO - { 04:41:52 INFO - "category": null, 04:41:52 INFO - "files": [ 04:41:52 INFO - { 04:41:52 INFO - "url": null, 04:41:52 INFO - "name": "https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:41:52 INFO - } 04:41:52 INFO - ], 04:41:52 INFO - "repository": "", 04:41:52 INFO - "rev": "662a3871dc77c9fe85abbaba483c5537ce94100b", 04:41:52 INFO - "who": "cbook@mozilla.com", 04:41:52 INFO - "when": 1447332026, 04:41:52 INFO - "number": 6653277, 04:41:52 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:41:52 INFO - "project": "", 04:41:52 INFO - "at": "Thu 12 Nov 2015 04:40:26", 04:41:52 INFO - "branch": "mozilla-central-linux64-talos", 04:41:52 INFO - "revlink": "", 04:41:52 INFO - "properties": [ 04:41:52 INFO - [ 04:41:52 INFO - "buildid", 04:41:52 INFO - "20151112025847", 04:41:52 INFO - "Change" 04:41:52 INFO - ], 04:41:52 INFO - [ 04:41:52 INFO - "builduid", 04:41:52 INFO - "b706f9cffc5943ecaea63184f82f66f7", 04:41:52 INFO - "Change" 04:41:52 INFO - ], 04:41:52 INFO - [ 04:41:52 INFO - "pgo_build", 04:41:52 INFO - "False", 04:41:52 INFO - "Change" 04:41:52 INFO - ] 04:41:52 INFO - ], 04:41:52 INFO - "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b" 04:41:52 INFO - } 04:41:52 INFO - ], 04:41:52 INFO - "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b" 04:41:52 INFO - } 04:41:52 INFO - } 04:41:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:41:52 INFO - Running post-action listener: _resource_record_post_action 04:41:52 INFO - ##### 04:41:52 INFO - ##### Running download-and-extract step. 04:41:52 INFO - ##### 04:41:52 INFO - Running pre-action listener: _resource_record_pre_action 04:41:52 INFO - Running main action method: download_and_extract 04:41:52 INFO - mkdir: /builds/slave/test/build/tests 04:41:52 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')]} 04:41:52 INFO - https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/test_packages.json 04:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/test_packages.json 04:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:41:59 INFO - Downloaded 1302 bytes. 04:41:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:41:59 INFO - Using the following test package requirements: 04:41:59 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'jsshell-linux-x86_64.zip'], 04:41:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:59 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:59 INFO - https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:07 INFO - Downloaded 21251305 bytes. 04:42:07 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 04:42:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:42:07 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 04:42:08 INFO - Return code: 0 04:42:08 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 04:42: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')]} 04:42:08 INFO - https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:13 INFO - Downloaded 21251305 bytes. 04:42:13 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 04:42:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:42:13 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 04:42:14 INFO - Return code: 0 04:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:14 INFO - https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:15 INFO - Downloaded 11131693 bytes. 04:42:15 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 04:42:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:15 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 04:42:15 INFO - Return code: 0 04:42:15 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')]} 04:42:15 INFO - https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yKoE63yXQxWM1pfFJKo5mw/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 04:42:16 INFO - Downloaded 55645318 bytes. 04:42:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:42:16 INFO - mkdir: /builds/slave/test/properties 04:42:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:16 INFO - Contents: 04:42:16 INFO - build_url:https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:42:16 INFO - Running post-action listener: _resource_record_post_action 04:42:16 INFO - Running post-action listener: set_extra_try_arguments 04:42:16 INFO - ##### 04:42:16 INFO - ##### Running populate-webroot step. 04:42:16 INFO - ##### 04:42:16 INFO - Running pre-action listener: _resource_record_pre_action 04:42:16 INFO - Running main action method: populate_webroot 04:42:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:42:16 INFO - '../fennec_ids.txt'], 04:42:16 INFO - 'tests': ['tcheck2']}, 04:42:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:16 INFO - '--tppagecycles', 04:42:16 INFO - '7'], 04:42:16 INFO - 'tests': ['tsvgm']}}, 04:42:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:42:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:42:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:42:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'tests': ['damp', 'tps']}, 04:42:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['damp', 'tps']}, 04:42:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:42:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:16 INFO - 'other': {'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'other_l64': {'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:42:16 INFO - 'ts_paint', 04:42:16 INFO - 'tpaint', 04:42:16 INFO - 'sessionrestore', 04:42:16 INFO - 'sessionrestore_no_auto_restore']}, 04:42:16 INFO - 'svgr': {'tests': ['tsvgx', 04:42:16 INFO - 'tsvgr_opacity', 04:42:16 INFO - 'tart', 04:42:16 INFO - 'tscrollx', 04:42:16 INFO - 'cart']}, 04:42:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['tsvgx', 04:42:16 INFO - 'tsvgr_opacity', 04:42:16 INFO - 'tart', 04:42:16 INFO - 'tscrollx', 04:42:16 INFO - 'cart']}, 04:42:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'tests': ['tp5o']}, 04:42:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'talos_options': ['--e10s'], 04:42:16 INFO - 'tests': ['tp5o']}, 04:42:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'talos_options': ['--xperf_path', 04:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:16 INFO - 'tests': ['tp5n']}, 04:42:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:16 INFO - 'talos_options': ['--e10s', 04:42:16 INFO - '--xperf_path', 04:42:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:16 INFO - 'tests': ['tp5n']}}, 04:42:16 INFO - 'talos.zip': {'path': '', 04:42:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:16 INFO - Running post-action listener: _resource_record_post_action 04:42:16 INFO - ##### 04:42:16 INFO - ##### Running create-virtualenv step. 04:42:16 INFO - ##### 04:42:16 INFO - Running pre-action listener: _resource_record_pre_action 04:42:16 INFO - Running main action method: create_virtualenv 04:42:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:16 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 04:42:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:16 INFO - Using real prefix '/usr' 04:42:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:19 INFO - Installing pip.................done. 04:42:19 INFO - Return code: 0 04:42:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:19 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 04:42:19 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 04:42:19 INFO - Using env: {'DISPLAY': ':0', 04:42:19 INFO - 'HOME': '/home/cltbld', 04:42:19 INFO - 'LANG': 'en_US.UTF-8', 04:42:19 INFO - 'LANGUAGE': 'en_US:en', 04:42:19 INFO - 'LOGNAME': 'cltbld', 04:42:19 INFO - 'MAIL': '/var/mail/cltbld', 04:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:19 INFO - 'MOZ_NO_REMOTE': '1', 04:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:19 INFO - 'NO_EM_RESTART': '1', 04:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:19 INFO - 'PWD': '/builds/slave/test', 04:42:19 INFO - 'SHELL': '/bin/bash', 04:42:19 INFO - 'SHLVL': '1', 04:42:19 INFO - 'TERM': 'linux', 04:42:19 INFO - 'TMOUT': '86400', 04:42:19 INFO - 'USER': 'cltbld', 04:42:19 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:19 INFO - '_': '/tools/buildbot/bin/python'} 04:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:19 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 04:42:19 INFO - Cleaning up... 04:42:19 INFO - Return code: 0 04:42:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:19 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 04:42:19 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 04:42:19 INFO - Using env: {'DISPLAY': ':0', 04:42:19 INFO - 'HOME': '/home/cltbld', 04:42:19 INFO - 'LANG': 'en_US.UTF-8', 04:42:19 INFO - 'LANGUAGE': 'en_US:en', 04:42:19 INFO - 'LOGNAME': 'cltbld', 04:42:19 INFO - 'MAIL': '/var/mail/cltbld', 04:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:19 INFO - 'MOZ_NO_REMOTE': '1', 04:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:19 INFO - 'NO_EM_RESTART': '1', 04:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:19 INFO - 'PWD': '/builds/slave/test', 04:42:19 INFO - 'SHELL': '/bin/bash', 04:42:19 INFO - 'SHLVL': '1', 04:42:19 INFO - 'TERM': 'linux', 04:42:19 INFO - 'TMOUT': '86400', 04:42:19 INFO - 'USER': 'cltbld', 04:42:19 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:19 INFO - '_': '/tools/buildbot/bin/python'} 04:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:19 INFO - Downloading/unpacking psutil>=0.7.1 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:19 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 04:42:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:42:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:21 INFO - Installing collected packages: psutil 04:42:21 INFO - Running setup.py install for psutil 04:42:21 INFO - building 'psutil._psutil_linux' extension 04:42:21 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 04:42:21 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 04:42:21 INFO - building 'psutil._psutil_posix' extension 04:42:21 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 04:42:22 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 04:42:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:22 INFO - Successfully installed psutil 04:42:22 INFO - Cleaning up... 04:42:22 INFO - Return code: 0 04:42:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:22 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 04:42:22 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 04:42:22 INFO - Using env: {'DISPLAY': ':0', 04:42:22 INFO - 'HOME': '/home/cltbld', 04:42:22 INFO - 'LANG': 'en_US.UTF-8', 04:42:22 INFO - 'LANGUAGE': 'en_US:en', 04:42:22 INFO - 'LOGNAME': 'cltbld', 04:42:22 INFO - 'MAIL': '/var/mail/cltbld', 04:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:22 INFO - 'MOZ_NO_REMOTE': '1', 04:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:22 INFO - 'NO_EM_RESTART': '1', 04:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:22 INFO - 'PWD': '/builds/slave/test', 04:42:22 INFO - 'SHELL': '/bin/bash', 04:42:22 INFO - 'SHLVL': '1', 04:42:22 INFO - 'TERM': 'linux', 04:42:22 INFO - 'TMOUT': '86400', 04:42:22 INFO - 'USER': 'cltbld', 04:42:22 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:22 INFO - '_': '/tools/buildbot/bin/python'} 04:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:42:22 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 04:42:22 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 04:42:22 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 04:42:22 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 04:42:22 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 04:42:22 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 04:42:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:42:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:42:24 INFO - Installing collected packages: mozsystemmonitor 04:42:24 INFO - Running setup.py install for mozsystemmonitor 04:42:24 INFO - Successfully installed mozsystemmonitor 04:42:24 INFO - Cleaning up... 04:42:24 INFO - Return code: 0 04:42:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:24 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 04:42:24 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 04:42:24 INFO - Using env: {'DISPLAY': ':0', 04:42:24 INFO - 'HOME': '/home/cltbld', 04:42:24 INFO - 'LANG': 'en_US.UTF-8', 04:42:24 INFO - 'LANGUAGE': 'en_US:en', 04:42:24 INFO - 'LOGNAME': 'cltbld', 04:42:24 INFO - 'MAIL': '/var/mail/cltbld', 04:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:24 INFO - 'MOZ_NO_REMOTE': '1', 04:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:24 INFO - 'NO_EM_RESTART': '1', 04:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:24 INFO - 'PWD': '/builds/slave/test', 04:42:24 INFO - 'SHELL': '/bin/bash', 04:42:24 INFO - 'SHLVL': '1', 04:42:24 INFO - 'TERM': 'linux', 04:42:24 INFO - 'TMOUT': '86400', 04:42:24 INFO - 'USER': 'cltbld', 04:42:24 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:24 INFO - '_': '/tools/buildbot/bin/python'} 04:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Downloading docopt-0.6.1.tar.gz 04:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:27 INFO - Running setup.py install for blobuploader 04:42:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:27 INFO - Running setup.py install for requests 04:42:27 INFO - Running setup.py install for docopt 04:42:27 INFO - Successfully installed blobuploader requests docopt 04:42:27 INFO - Cleaning up... 04:42:27 INFO - Return code: 0 04:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:27 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 04:42:27 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 04:42:27 INFO - Using env: {'DISPLAY': ':0', 04:42:27 INFO - 'HOME': '/home/cltbld', 04:42:27 INFO - 'LANG': 'en_US.UTF-8', 04:42:27 INFO - 'LANGUAGE': 'en_US:en', 04:42:27 INFO - 'LOGNAME': 'cltbld', 04:42:27 INFO - 'MAIL': '/var/mail/cltbld', 04:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:27 INFO - 'MOZ_NO_REMOTE': '1', 04:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:27 INFO - 'NO_EM_RESTART': '1', 04:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:27 INFO - 'PWD': '/builds/slave/test', 04:42:27 INFO - 'SHELL': '/bin/bash', 04:42:27 INFO - 'SHLVL': '1', 04:42:27 INFO - 'TERM': 'linux', 04:42:27 INFO - 'TMOUT': '86400', 04:42:27 INFO - 'USER': 'cltbld', 04:42:27 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:27 INFO - '_': '/tools/buildbot/bin/python'} 04:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:27 INFO - Running setup.py (path:/tmp/pip-uf3e69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:27 INFO - Running setup.py (path:/tmp/pip-gOmpKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:28 INFO - Running setup.py (path:/tmp/pip-fEGXDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:28 INFO - Running setup.py (path:/tmp/pip-6iam91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:28 INFO - Running setup.py (path:/tmp/pip-Usdl2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:28 INFO - Running setup.py (path:/tmp/pip-WmqB0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:28 INFO - Running setup.py (path:/tmp/pip-rqiJ8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:28 INFO - Running setup.py (path:/tmp/pip-i4FkEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:28 INFO - Running setup.py (path:/tmp/pip-H3lmfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:28 INFO - Running setup.py (path:/tmp/pip-GpjZsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:28 INFO - Running setup.py (path:/tmp/pip-RuAkxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:28 INFO - Running setup.py (path:/tmp/pip-TvyYDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:28 INFO - Running setup.py (path:/tmp/pip-ecQR2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:28 INFO - Running setup.py (path:/tmp/pip-axAxg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:28 INFO - Running setup.py (path:/tmp/pip-KezheP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:28 INFO - Running setup.py (path:/tmp/pip-1Co04p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:29 INFO - Running setup.py (path:/tmp/pip-kmhbiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:29 INFO - Running setup.py install for manifestparser 04:42:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Running setup.py install for mozcrash 04:42:29 INFO - Running setup.py install for mozdebug 04:42:29 INFO - Running setup.py install for mozdevice 04:42:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Running setup.py install for mozfile 04:42:29 INFO - Running setup.py install for mozhttpd 04:42:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Running setup.py install for mozinfo 04:42:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Running setup.py install for mozInstall 04:42:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:29 INFO - Running setup.py install for mozleak 04:42:29 INFO - Running setup.py install for mozlog 04:42:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Running setup.py install for moznetwork 04:42:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Running setup.py install for mozprocess 04:42:30 INFO - Running setup.py install for mozprofile 04:42:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Running setup.py install for mozrunner 04:42:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Running setup.py install for mozscreenshot 04:42:30 INFO - Running setup.py install for moztest 04:42:30 INFO - Running setup.py install for mozversion 04:42:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:30 INFO - Cleaning up... 04:42:30 INFO - Return code: 0 04:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:30 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')]} 04:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:30 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')]} 04:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:30 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:30 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 04:42:30 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 04:42:30 INFO - Using env: {'DISPLAY': ':0', 04:42:30 INFO - 'HOME': '/home/cltbld', 04:42:30 INFO - 'LANG': 'en_US.UTF-8', 04:42:30 INFO - 'LANGUAGE': 'en_US:en', 04:42:30 INFO - 'LOGNAME': 'cltbld', 04:42:30 INFO - 'MAIL': '/var/mail/cltbld', 04:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:30 INFO - 'MOZ_NO_REMOTE': '1', 04:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:30 INFO - 'NO_EM_RESTART': '1', 04:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:30 INFO - 'PWD': '/builds/slave/test', 04:42:30 INFO - 'SHELL': '/bin/bash', 04:42:30 INFO - 'SHLVL': '1', 04:42:30 INFO - 'TERM': 'linux', 04:42:30 INFO - 'TMOUT': '86400', 04:42:30 INFO - 'USER': 'cltbld', 04:42:30 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:30 INFO - '_': '/tools/buildbot/bin/python'} 04:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:31 INFO - Running setup.py (path:/tmp/pip-VKsYIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:31 INFO - Running setup.py (path:/tmp/pip-9r7uRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:31 INFO - Running setup.py (path:/tmp/pip-bg51yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:31 INFO - Running setup.py (path:/tmp/pip-Jpl5L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:31 INFO - Running setup.py (path:/tmp/pip-T_019N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:31 INFO - Running setup.py (path:/tmp/pip-AlEjmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:31 INFO - Running setup.py (path:/tmp/pip-fIaHBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:31 INFO - Running setup.py (path:/tmp/pip-lZxtm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:31 INFO - Running setup.py (path:/tmp/pip-k2Yq5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:31 INFO - Running setup.py (path:/tmp/pip-YydSxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:31 INFO - Running setup.py (path:/tmp/pip-DioNFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:31 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)) 04:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:31 INFO - Running setup.py (path:/tmp/pip-wACNi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:32 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)) 04:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:32 INFO - Running setup.py (path:/tmp/pip-ifRo_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:32 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)) 04:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:32 INFO - Running setup.py (path:/tmp/pip-u05Dlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:32 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)) 04:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:32 INFO - Running setup.py (path:/tmp/pip-wku0Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:32 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)) 04:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:32 INFO - Running setup.py (path:/tmp/pip-6f2AGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:32 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)) 04:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:32 INFO - Running setup.py (path:/tmp/pip-1oA8EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:32 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)) 04:42:32 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)) 04:42:32 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)) 04:42:32 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)) 04:42:32 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)) 04:42:32 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)) 04:42:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:34 INFO - Downloading blessings-1.5.1.tar.gz 04:42:34 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 04:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:34 INFO - Installing collected packages: blessings 04:42:34 INFO - Running setup.py install for blessings 04:42:34 INFO - Successfully installed blessings 04:42:34 INFO - Cleaning up... 04:42:34 INFO - Return code: 0 04:42:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:34 INFO - Reading from file tmpfile_stdout 04:42:34 INFO - Current package versions: 04:42:34 INFO - argparse == 1.2.1 04:42:34 INFO - blessings == 1.5.1 04:42:34 INFO - blobuploader == 1.2.4 04:42:34 INFO - docopt == 0.6.1 04:42:34 INFO - manifestparser == 1.1 04:42:34 INFO - mozInstall == 1.12 04:42:34 INFO - mozcrash == 0.16 04:42:34 INFO - mozdebug == 0.1 04:42:34 INFO - mozdevice == 0.47 04:42:34 INFO - mozfile == 1.2 04:42:34 INFO - mozhttpd == 0.7 04:42:34 INFO - mozinfo == 0.9 04:42:34 INFO - mozleak == 0.1 04:42:34 INFO - mozlog == 3.0 04:42:34 INFO - moznetwork == 0.27 04:42:34 INFO - mozprocess == 0.22 04:42:34 INFO - mozprofile == 0.27 04:42:34 INFO - mozrunner == 6.11 04:42:34 INFO - mozscreenshot == 0.1 04:42:34 INFO - mozsystemmonitor == 0.0 04:42:34 INFO - moztest == 0.7 04:42:34 INFO - mozversion == 1.4 04:42:34 INFO - psutil == 3.1.1 04:42:34 INFO - requests == 1.2.3 04:42:34 INFO - wsgiref == 0.1.2 04:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:34 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')]} 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:34 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')]} 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:34 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 0x7f9caabf1c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, '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': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', '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 04:42:34 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 04:42:34 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 04:42:34 INFO - Using env: {'DISPLAY': ':0', 04:42:34 INFO - 'HOME': '/home/cltbld', 04:42:34 INFO - 'LANG': 'en_US.UTF-8', 04:42:34 INFO - 'LANGUAGE': 'en_US:en', 04:42:34 INFO - 'LOGNAME': 'cltbld', 04:42:34 INFO - 'MAIL': '/var/mail/cltbld', 04:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:34 INFO - 'MOZ_NO_REMOTE': '1', 04:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:34 INFO - 'NO_EM_RESTART': '1', 04:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:34 INFO - 'PWD': '/builds/slave/test', 04:42:34 INFO - 'SHELL': '/bin/bash', 04:42:34 INFO - 'SHLVL': '1', 04:42:34 INFO - 'TERM': 'linux', 04:42:34 INFO - 'TMOUT': '86400', 04:42:34 INFO - 'USER': 'cltbld', 04:42:34 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:34 INFO - '_': '/tools/buildbot/bin/python'} 04:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 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)) 04:42:34 INFO - Cleaning up... 04:42:34 INFO - Return code: 0 04:42:34 INFO - Running post-action listener: _resource_record_post_action 04:42:34 INFO - Running post-action listener: _start_resource_monitoring 04:42:34 INFO - Starting resource monitoring. 04:42:34 INFO - ##### 04:42:34 INFO - ##### Running install step. 04:42:34 INFO - ##### 04:42:34 INFO - Running pre-action listener: _resource_record_pre_action 04:42:34 INFO - Running main action method: install 04:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:34 INFO - Reading from file tmpfile_stdout 04:42:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:35 INFO - Reading from file tmpfile_stdout 04:42:35 INFO - Output received: 04:42:35 INFO - Usage: mozinstall [options] installer 04:42:35 INFO - Options: 04:42:35 INFO - -h, --help show this help message and exit 04:42:35 INFO - -d DEST, --destination=DEST 04:42:35 INFO - Directory to install application into. [default: 04:42:35 INFO - "/builds/slave/test"] 04:42:35 INFO - --app=APP Application being installed. [default: firefox] 04:42:35 INFO - mkdir: /builds/slave/test/build/application 04:42:35 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'] 04:42:35 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 04:42:49 INFO - Reading from file tmpfile_stdout 04:42:49 INFO - Output received: 04:42:49 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:49 INFO - Running post-action listener: _resource_record_post_action 04:42:49 INFO - ##### 04:42:49 INFO - ##### Running run-tests step. 04:42:49 INFO - ##### 04:42:49 INFO - Running pre-action listener: _resource_record_pre_action 04:42:49 INFO - Running main action method: run_tests 04:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:49 INFO - Python 2.7.3 04:42:49 INFO - Return code: 0 04:42:49 INFO - grabbing minidump binary from tooltool 04:42:49 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')]} 04:42:49 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 0x170cac0>, '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 0x170d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170de50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:49 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 04:42:49 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 04:42:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:49 INFO - Return code: 0 04:42:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 04:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 04:42:49 INFO - Using env: {'DISPLAY': ':0', 04:42:49 INFO - 'HOME': '/home/cltbld', 04:42:49 INFO - 'LANG': 'en_US.UTF-8', 04:42:49 INFO - 'LANGUAGE': 'en_US:en', 04:42:49 INFO - 'LOGNAME': 'cltbld', 04:42:49 INFO - 'MAIL': '/var/mail/cltbld', 04:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:49 INFO - 'MOZ_NO_REMOTE': '1', 04:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:49 INFO - 'NO_EM_RESTART': '1', 04:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:49 INFO - 'PWD': '/builds/slave/test', 04:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:49 INFO - 'SHELL': '/bin/bash', 04:42:49 INFO - 'SHLVL': '1', 04:42:49 INFO - 'TERM': 'linux', 04:42:49 INFO - 'TMOUT': '86400', 04:42:49 INFO - 'USER': 'cltbld', 04:42:49 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447331845.948654-202946340', 04:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:49 INFO - '_': '/tools/buildbot/bin/python'} 04:42:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 04:42:49 INFO - mozversion INFO | application_buildid: 20151112025847 04:42:49 INFO - mozversion INFO | application_changeset: 662a3871dc77c9fe85abbaba483c5537ce94100b 04:42:49 INFO - mozversion INFO | application_display_name: Nightly 04:42:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:49 INFO - mozversion INFO | application_name: Firefox 04:42:49 INFO - mozversion INFO | application_remotingname: firefox 04:42:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:42:49 INFO - mozversion INFO | application_vendor: Mozilla 04:42:49 INFO - mozversion INFO | application_version: 45.0a1 04:42:49 INFO - mozversion INFO | platform_buildid: 20151112025847 04:42:49 INFO - mozversion INFO | platform_changeset: 662a3871dc77c9fe85abbaba483c5537ce94100b 04:42:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:42:49 INFO - mozversion INFO | platform_version: 45.0a1 04:42:49 INFO - 2015-11-12 04:42:49,367 DEBUG : using testdate: 1447332169 04:42:49 INFO - 2015-11-12 04:42:49,367 DEBUG : actual date: 1447332169 04:42:49 INFO - 2015-11-12 04:42:49,414 INFO : starting webserver on 'localhost:41757' 04:42:49 INFO - 2015-11-12 04:42:49,415 INFO : Starting test suite talos-linux64-ix-039 04:42:49 INFO - 2015-11-12 04:42:49,415 INFO : Starting test dromaeo_css 04:42:49 INFO - 2015-11-12 04:42:49,416 DEBUG : operating with platform_type : linux_ 04:42:49 INFO - 2015-11-12 04:42:49,416 INFO : Initialising browser for dromaeo_css test... 04:42:49 INFO - 2015-11-12 04:42:49,426 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08Yuaf/profile http://localhost:41757/getInfo.html 04:42:54 INFO - 2015-11-12 04:42:54,099 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:42:54 INFO - 2015-11-12 04:42:54,099 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:42:54 INFO - 2015-11-12 04:42:54,100 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:42:54 INFO - 2015-11-12 04:42:54,100 DEBUG : BROWSER_OUTPUT: __metrics 04:42:54 INFO - 2015-11-12 04:42:54,201 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:55 INFO - 2015-11-12 04:42:55,644 INFO : Browser initialized. 04:42:55 INFO - 2015-11-12 04:42:55,645 INFO : Running cycle 1/1 for dromaeo_css test... 04:42:55 INFO - 2015-11-12 04:42:55,645 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08Yuaf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:43:07 INFO - 2015-11-12 04:43:07,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 04:43:07 INFO - 2015-11-12 04:43:07,567 DEBUG : BROWSER_OUTPUT: 04:43:59 INFO - 2015-11-12 04:43:59,143 DEBUG : BROWSER_OUTPUT: 1447332239141 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] 04:46:11 INFO - 2015-11-12 04:46:11,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41757/tests/dromaeo/cssquery-ext.html) 04:46:12 INFO - 2015-11-12 04:46:12,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 250839040 04:46:12 INFO - 2015-11-12 04:46:12,487 DEBUG : BROWSER_OUTPUT: 04:49:15 INFO - 2015-11-12 04:49:15,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-ext.html (next: http://localhost:41757/tests/dromaeo/cssquery-jquery.html) 04:49:15 INFO - 2015-11-12 04:49:15,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 217960448 04:49:15 INFO - 2015-11-12 04:49:15,642 DEBUG : BROWSER_OUTPUT: 04:52:17 INFO - 2015-11-12 04:52:17,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41757/tests/dromaeo/cssquery-mootools.html) 04:52:18 INFO - 2015-11-12 04:52:18,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 215252992 04:52:18 INFO - 2015-11-12 04:52:18,272 DEBUG : BROWSER_OUTPUT: 04:55:20 INFO - 2015-11-12 04:55:20,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41757/tests/dromaeo/cssquery-prototype.html) 04:55:20 INFO - 2015-11-12 04:55:20,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 195018752 04:55:20 INFO - 2015-11-12 04:55:20,833 DEBUG : BROWSER_OUTPUT: 04:58:23 INFO - 2015-11-12 04:58:23,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41757/tests/dromaeo/cssquery-yui.html) 04:58:24 INFO - 2015-11-12 04:58:24,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 201498624 04:58:24 INFO - 2015-11-12 04:58:24,123 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/dromaeo/cssquery-yui.html (next: http://localhost:41757/tests/dromaeo/cssquery-dojo.html) 05:01:26 INFO - 2015-11-12 05:01:26,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 245149696 05:01:26 INFO - 2015-11-12 05:01:26,795 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,797 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:26 INFO - 2015-11-12 05:01:26,797 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:26 INFO - 2015-11-12 05:01:26,797 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:26 INFO - 2015-11-12 05:01:26,797 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:26 INFO - 2015-11-12 05:01:26,799 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2670.919872403828;2750.669919609647;2761.282066662667;2763.4334961332916;2780.471710375028;4583.839565615204;4678.508756580557;4735.171345014626;4767.713937163769;4823.638227132966;4691.601213896823;4729.692569982949;4788.688735232207;4789.568938795508;4797.944452220506;4325.52419233884;4379.080393117433;4401.603855652983;4485.3944717463055;4492.191405547001;4223.809928553223;4427.690061695683;4449.955500444987;4480.641548676098;4538.160440318552;4304.5480224576595;4344.304911214223;4388.27593447084;4395.318725597537;4429.379886815848;4372.5627437256335;4426.62373698236;4430;4439.422875026258;4475.977620111878;4167.874963751093;4417.602415782595;4428.645708343325;4432.601065904084;4471.6646251531265;4522.479914809806;4603.447586289667;4621.4223222097235;4663.976680116578;4675.111728771557;5023.120953833065;5030.949690503085;5054.848354549369;5066.113430149709;5092.541671249568;4868.707877527359;4996.650234483587;5055.9241611375855;5061.493850614946;5077.136886729265;4649.5815376616265;4687.976560117212;4713.057388522309;4734.763261836894;4766.451858036301;5209.29674493946;5235.633505654644;5236.607254455931;5238.3190185276435;5277.498637629419;4797.328374027639;4912.606991440676;5028.547430731179;5031.018951304461;5031.7987280509105;4943.8516844494725;5011.5489605935645;5019.372578427697;5049.873753156127;5052.595792336604;5010.949890501121;5084.262781896604;5087.949120508822;5096.898062038813;5137.075326441276;4818.759062046884;4950.6782059166035;5048.3941926969;5056;5056.595472362203;4125.66994640428;4182.121754431542;4194.790260486963;4216.451861258078;4218.451601291812;3661.2494438640015;3666.5966743658178;3677.3748462761396;3694.7598406103516;3727.7204209684382;4133.772642504691;4312.913741725148;4315.395844581761;4321.891952701208;4354.259775838115;4884.1941079722155;4983.651144419856;5023.34696489454;5031.320771695774;5073;4294.89262768427;4354.804033818486;4366.541513141075;4369.934450983238;4410.360497727876;4396.802143903532;4516.977415112903;4518.299663552155;4528;4532.524084971096;4731.148393289172;4739.502352252964;4750.667453278237;4850.660453768202;4895.583875370633;5061.9493805061475;5064.417591976822;5074;5078.669886457368;5125.461826508163;4640.9535904640525;4779.402574678165;4795.304680821331;4818.518148185153;4850.151223535938;4874.488178741323;4904.411470623548;4959.752012399294;4962.5533701967;4995.325631039763;5045.747712614281;5077.111505486599;5089.109405854035;5099.23511473282;5114.360704911886;4701.600363968964;4931.802727890844;4943.060818444484;4943.728094954812;4976.32819569368;4751.904961900674;4776.522347765195;4821;4847.61219102478;4858.975705121452;4827.131116398941;4827.686200396963;4830.275458681226;4841.491643377535;4873.220284754564;4803.183458811941;4941.75291235444;4959.132151873336;4966.230234313687;5009.774560144875;4756.096341695067;4795.232762757942;4818.734969576707;4837.830675926326;4869.245266983623 05:01:26 INFO - 2015-11-12 05:01:26,799 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.0249051044203;576.2336092996316;576.8327185116316;586.8151532267335;603.2519675602251;28160;36868;37558.812205939;37638.247235055285;37718.24563508728;39912;40647.39028914569;40788.184236315254;40843.38734918978;40972.79513602435;7029.648517574126;7152.570845749246;7740.690372385098;7896.644650990691;7900.486468379566;9922.057404546593;10174.64388746394;10175.643852465166;10181.898181018207;10186.337888037291;10058.49707514625;10189.439580823051;10191.439470829102;10193.490325483695;10197.490125493732;7210.531315464478;7382.7046918123215;10023.2482563808;10159.339642923187;10474.371537707762;9891.109800117953;10012.499375031291;10013.299069065168;10024.147947424404;10028.298019138663;38168;38776.61223387758;38791.806040969896;38796.80601596974;38833;2487.838290511129;2510.8367956082798;2694.0840114361017;2705.971730742325;3070.6929307069113;29162.41675166506;29316.853415732785;29348.706512934812;29637.85181074081;31944.840275798706;2439.573074711936;2442.829001969863;2452.460458699083;2470.700980294293;2491.364702000996;218885;220872;221031;221462.9999999984;221585;47298.29052564214;55595.44404555984;55885;55997;56047.719761400935;47782;65588;66941;67120;67616.323836761;11819.054475641928;11885.40572971348;11890.28658280506;11911;12098;9408.435493870253;9525.857112143323;9544.665936692183;9549.283803714749;9561.187299079516;18907.29834314918;19143.425697229104;19173;19181.712274315898;19243.422697319103;7577.507462014952;7630.923690763132;7860.7248746294745;7872.134065252818;7897.210278972057;828.7389472316322;845.4546817302928;948.7390967483859;968.951552422376;994.7910938702809;25797;26134.738652613232;26470.6029409559;26487.41075535474;29830.55254171189;933.8272419602396;940.7648087978006;1005.5374527717186;1035.989909837902;1037.180627304436;13676.794848077287;13778.862211377958;14000.36998335057;14035.71928561423;14036.859631403555;325656;329243;331598;332589;332927;45477.54522454733;45951.77024114858;45955.5404445958;46085.30872036855;46190.53809461863;1192.928424294545;1204.3015051270243;1221.3465795799204;1222.9999999999823;1227.914046016788;25033.87483062646;25575.360615984748;26284.474310514066;26839;29875.253118672208;41725.37411938884;42179.367309491;42406.57593424026;42469;42494.575054249064;250104;252623;252754;252928;253106;23987.520249595258;24413.145539906018;28111.57832632553;28713.28216794597;29375;33737.83131084329;33809.154771129935;44003.33994990142;45621.54378456306;45786.77106614446;34293.82853085719;34683.4797478033;34813.65186348104;35302.29395412026;37002.259954801295;28550.843457305575;31411.37177256488;33795.4930676045;34646.480302794975;34774.82612586921;31249.68750312468;32261.51607725933;32411.18972025718;32478.83760581182;32526.349473009934;29055.564166537097;31369;33096.83451582823;35240.295194096485;35979.820100900375;23904.282871513882;24256.75743242545;24432.755672443047;24523.264302070966;24534.263972080866 05:01:26 INFO - 2015-11-12 05:01:26,800 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.92554175310556;331.8573013604149;331.86891177984694;334.81919763327807;335.5453360696258;9466.100720431565;9754.512274386288;11142.442877856105;15149.166795826226;15709.84290157098;10128.645497407591;10444.791104177912;10467.947660261689;10490.213234007442;10927.125829933606;4054.4931883514487;4153.376993450991;4158.896027599304;4159.438475805758;4161.791910404483;3190.425723369804;3282.4912138618433;4064.309067458539;6203.751849925998;6526.836829079287;6206.37936206378;6425.164728585278;6474.514411419139;6505.316941721122;6516.641584712839;6423.421892029716;6432.228132624068;6451.548391612566;6465.644389558573;6465.709043093025;5994.670293133876;6111.449969502766;6122.602030868024;6172.321044685081;6186.072089186613;19349.226030958744;19485.512862178417;20016.59966800656;20705.482362940897;21147.15411383543;1812.8459080978132;1851.3150134450339;1864.4033909149077;1897.5920177161977;1971.8521110916738;13324.200547967055;13756.449742010307;13779.242141682204;14015.859841401558;14171.78742318866;1885.236479225902;1906.1231833356674;1908.055512521311;1943.6112777444569;1966.1643801384498;59931;61149;61817;62390.68804655993;63075.68462157706;14984.775228371584;15589.298481568356;15602.453914112952;15687.843121568867;15691.843081569266;22827.543449130924;22845.543089138126;22983.42541436444;23068.884655576614;23104.4223894404;7270.418366530665;7917.643706033243;8376.790580235422;8379.413441059067;8437.451565648213;6955.791326260221;6968.0941477607585;6997.440204783605;7020.157581090302;7035.366816986496;6442.323556026549;7428.888566671504;7592.240775922363;7593.620318984029;7600.567818298202;1074.4681382715605;1081.4430568257353;1093.8742044664807;1100.6312885183554;2071.4200023993308;416.4149370134965;424.54573606241024;433.93707912352534;449.869537834031;490.2107606753125;9837.262205334628;10887.891121088845;10945.616903408343;11037.337759734442;11364.659060228207;455.55583306276117;455.84956964201734;458.5689451915256;465.3368949247309;474.0306074078518;6115.388461153849;6214.937850621526;6215.471684906744;6215.564910456224;6220.284667263232;119460;120419.39790301168;472323;475105;477922;68029.31970680329;69387.30612693909;70342.9448558272;70416;70427.64786176036;513.0585375835309;526.1870410216225;526.7682219823265;526.9920951185735;527.6833899660173;10335.17318614524;10372.896271037192;10397.272190946864;10488.31825931312;10517.631882884063;29062.41875162527;29700.702992969793;29770;30142.397152057274;30634.84682576573;35457.93626191218;36069.27861442809;38841.6115838838;38956.80521597374;38971.6102838968;5614.578906581941;6161.5686901918225;6246.843828904313;6247.562670613013;6268.498520118288;11370.090392768394;11489;11527.538898443969;11548.59579914699;11583.5945741902;10016.298859079794;10039.69880903574;10338.534765935401;10395.220358472994;10448.216383771096;8442.831143376976;8448.23965843077;9661.758456038375;9911.10800028001;10114.241431892491;9214.401063930824;9243.2143267823;9349.579268932779;9359.438433694;9492;6051.062085376773;6055.515558755377;6065.939340606714;6066.636001839904;6089.208402907594;9403.43579385239;9404;9503.61985520599;9593.32846700752;9753.9024609753 05:01:26 INFO - 2015-11-12 05:01:26,801 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1205.1323047405876;1322.0018885741265;1364.399664147775;1445.342369222004;1677.3626022111603;6073.544484163689;6684.832879178017;6851;6933.202681691607;6935.1677798664105;6851.383375496204;6971.651417429121;6982.441404687625;6986.091808064957;6994.125734283215;1744.5289771761616;1779.8843075200136;1895.3650527073412;1917.769867615888;1991.8804871707744;2045.9181632734746;2048.3752455501067;2050.2209160518983;2050.846186536008;2051.7640471345762;1985.5433250352428;2015.6472617291915;2042.4587484316594;2042.7446569178853;2047.119738512439;1969.6454638165123;1981.920723171086;2020.8989550522415;2027.5032617008853;2029.4926268432819;2048.7131801547794;2074.4502706782714;2078.044099714133;2078.7089807426973;2079.396974877284;7079.823004424879;7104.147502299706;7156.499045066847;7163.1762347330205;7172.713091476335;4047.352423612208;4094.877153685394;4111.568285330057;4115.1975364803875;4115.650169735576;2329.871857047862;2519.748025197484;2653.230563136688;2662.773664238542;2684.2618279973162;768.5158350239369;800.7877912353231;818.0224631565281;827.1563005734117;840.0297656207091;9169.770755731093;9238.769030774218;9327.626894924195;9333.253339732873;9341.813163736755;3836.731428799957;3845.307844587945;3883.5533913599734;3905.726599138033;3917.941230881539;8099.878501822477;8158.510489370657;8181.590920454072;8182.22268884455;8191.221833925768;4150.896227594274;4160.895977600584;4169.2703776838935;4175.937360939588;4188.8115034822895;3733.029412352808;3739.9252014959548;3747.45661879026;3757.887263382103;3759.49246851677;3345.347657206821;3381.560397148355;3386.813725245135;3390.627031026585;3433.141714571357;1074.919381046409;1085.1210519479248;1086.326477583903;1086.8261078227604;1093.1637297467444;1118.2340097033557;1131.6605018494583;1171.3147808531933;1173.221201287263;1192.350169157811;6571.737130514822;6609;6618.073469714244;6629.801105966829;6649.468042556584;400.51537639456586;403.1372862075161;405.904612416082;408.19585416728995;409.2224772931454;5153.201253805666;5166.689998600096;5181.792728290826;5219;5220.347456567929;8257.256846883689;8394.748157555283;8420.410571259952;8443.366747493963;8645.178708022728;8492.108328625529;8551.828963420698;8558.058613552505;8576.871346929802;8586.957065214634;6310.148130002391;6641.50188735837;6669.533132680665;6738.258791532928;6745.156855393076;6530.314316996837;6600.2409722882485;6630.867382652416;6637.70130344126;6640.634765087966;7425.405967522477;7486.064241969754;7531.435142364454;7539.132999704885;7556.2443755624;7545.660445280086;7557.2820582044615;7666.348360389429;7698.730544430918;7736.651850666621;6292.653904035322;6369.0764839099;6375.936240637534;6379.457746091634;6395.232572091379;6692.799216023527;6728.259891411843;6739.59562426256;6776.051352810709;6792.388685018372;6383.521235907233;6427;6465.224173099258;6510.0885875976455;6598.736050558116;6360.618362898056;6371.267304260069;6468.870622587616;6471.741130354733;6479.384458476437;5488.533474654699;5742.569307301886;5743.396943321059;5753.424657534213;5765.913511297418;5744.339400968942;5774.9133762994425;5780.075187969905;5786.392428794916;5810.070388737781;5440.102383106743;5713.771449141987;5745.712714364348;5760.0783874579865;5782.2194003808945 05:01:26 INFO - 2015-11-12 05:01:26,801 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.2318587601617;307.75994724115185;311.89083820662773;315.1506689471874;317.84107946026984;5247.239150323201;5248.448912864142;5256.579473642109;5263.210518422238;5285.418603953567;5008.098542262392;5083.5933125349975;5093.439721630618;5166.199239117934;5193.610479214055;4082.4896887889013;4082.9795851020776;4096.85661001865;4098.139390727951;4105.096878686684;3931.9803400983096;4070.715049946505;4092.263392589333;4092.570280120589;4097.405876147956;3948.6841052715713;3999.7400168988925;4040.030392705759;4066.125782956664;4070.308047631895;4052.8854564994567;4054.0270335119358;4062.1469491406842;4069.8168582413864;4072.8574499892657;3605.3330133925047;3606;3606.495090687306;3606.801625910574;3610.638936106395;4997.42529609096;5003.799848006075;5006.349174607314;5009.899802003976;5024.19612861944;4590.517995610479;4637.489876113625;4685.929711054337;4710.458297295821;4723.622110231207;5491.780328786844;5497;5497.422770609069;5505.504504594605;5510.393856675762;3958.4853968984135;3958.604139586047;3962.5046869141356;3962.8018599069933;3963.8810835674976;5743.971280143614;5760.337561180434;5764.5676574257095;5775.653460792366;5787.50806181475;3916.099297161669;4008.6392224699334;4015.297322968469;4029.49631296088;4073.287174744408;4071.145059537471;4071.959280407158;4073.592640735962;4075.2460794753065;4080.5307389649975;4633.397658304399;4634.629229661619;4634.698744581591;4637.25803871379;4641.651876109306;5464.726763661801;5498.037843377473;5501.202325662756;5513.917291240635;5525.171224316385;1454.7454195515743;1482.0959214878915;1501.2343704710677;1502.1738044075714;1504.9548513544391;1017.6285655735603;1037.1184493180888;1048.3185929146116;1054.7415883108688;1059.163261023798;4819.734914579662;4825.059113472839;4826.565609095198;4833.130036593447;4834.444038935497;5696.971515142481;5712.80005199816;5714.657120572779;5717.685527296038;5721.5708821838525;4661.440627124767;4722.669413141047;4740.170470167707;4793.736344501086;4818.855434336975;3106.08370530694;3107.502799552106;3118.953215701766;3134.9216269592985;3150.8109513429267;5305.283786688748;5341.893162136736;5356.276902618175;5357.732113394315;5358.946410535845;5820.883582328414;5828.038373668382;5829.708514574254;5831.9708401458565;5835.620684655484;5180;5437.619366644297;5437.782488700487;5437.864053398696;5446.509814116669;5762.769489220552;5764.538836893123;5764.7405866736935;5766.250387449605;5770.711464426678;5633.8309850704545;5637.746301416528;5643.040683083804;5645.661260324394;5646.181303711021;5294.629375943647;5392.379876314274;5429.131338985743;5430.891382172255;5438.374586922397;3955.129871428281;4018.738781979162;4021.5576286607866;4025.818838152232;4027.0536423940935;5746.195532625352;5746.3966283541295;5746.62646927965;5765.769369225184;5770.422957704364;5540.556755459635;5541.667499950016;5552.416996215339;5555.194496797861;5558.527525160407;5348.705821179872;5444.101723215784;5446.891062178655;5448.809291674773;5503.2020357048805;5371.5702743781185;5375.247465354775;5375.435579264277;5375.784968601369;5377.946220537745;5480.698561579152;5509.559235261089;5515.283013208257;5521.723913804213;5523.950449414599;5269.209618557247;5366.570674345965;5380.381256155592;5383.111786555174;5387.892242155213 05:01:26 INFO - 2015-11-12 05:01:26,802 DEBUG : BROWSER_OUTPUT: |5;yui.html;694.826293426643;708.5040471669831;716.0083284650759;717.2289788477389;722.7976166673327;11050.889491105097;11462.828057579132;11471.541138354476;11479.311241325526;11493.138014648914;11619.244749091304;11768.7646247075;11858.3477908715;11858.3477908715;11869.703257418569;601.9036954087325;615.8398816307747;780.9648565814538;801.7634797734682;804.4610111225493;773.7098588029489;782.5148407987027;792.5482474989259;793.0364607002491;793.0364607002491;832.2800777327599;836.9790755231137;837.3719710217337;838.2162677896156;838.4591938199858;643.3437893348781;659.7492952677976;821.2977903892146;835.0605568735173;847.8346722389136;605.252513146264;606.6633018674634;609.8536351275707;611.2909025530408;612.8712970276247;11100.111991040778;11206;11210.495527701272;11243.100551955824;11281;9450.4802235877;10333.79332413355;10538.367697938149;11111.000009999058;11439.485223164978;7596.468247222697;7664.808379790494;7701.807454813618;7829.686812527492;8670.956645216733;2968.807027543224;2996.625421822272;3074.677158898306;3114.5016797312323;3184.060702092865;42505.57494425047;42554.1489170218;42690.78654606707;42710.35934460985;42930.57069429297;7974;8193.426460147732;8199.385046121564;8222.62998165072;8255.876161857577;13154.21074735519;13205.075644704779;13208;13211.273379964003;13219;6250.15622890913;6260.655663938436;6297.685115744194;6410.326915673881;6431.517636177306;3417.965820341765;3544.8227588620466;3610.4403817408343;3612.3317186320614;3620.113072297304;2645.3386653336665;2696.4202696420366;2698.123109989222;2699.136276391575;2704.4591081783724;378.76138033039007;384.30632707961837;488.8509004753513;497.1672448648499;504.32672382369213;388.41543477066836;400.7815740421419;466.2935652486418;511.5728366813678;544.6976927805027;6475.384838440341;6607.933920660732;6986.685599148051;7719.589194373464;7763.534187948628;410.386472224027;422.97250678705785;429.5382463851372;496.201116202913;505.95699365553605;3242.9675703242665;3250.1224669339144;3258.5926759155104;3263.2168279613197;3267.820269885179;54904.72547637236;54987;55175.275461435434;55241.72379138159;55396.72301638466;44417.777911110235;44544;44613.33080003803;45734;46055.309170362474;41609.37585936213;42161.36757948633;42459.78770106191;42476.36285455721;42794.35808462876;7229.179852386294;7341.119065712149;7530.698772049276;7559.092908850973;7662.961685191538;32494.512582311756;32527;33370.666293336755;33395.1651208712;33853.83073084619;38807.6119238804;39203.41194882136;39667.80166099266;41313.79343103265;41835.58164418317;6175.783847565313;6414.198225221848;6541.8691626166255;6611.471082313499;6615.702293396713;10092.596296148073;10367.792644147226;10403.375797452178;10445.843312350473;10562.207834412604;8941.329400295133;9024.684136055206;9304.767380815263;9375.34372593912;9672.95163524178;8815.955920220358;8935;9201.723948281562;9315.34792564514;9336.486493242937;9387.483688397204;9545.761355966157;9596.18432433251;9656.420614763138;9745.512724363613;8341.624626891684;8542.82914341722;8581.442206256574;8676.652933882575;8696.304295656459;8258.628361723857;8434.451760635538;8442.197991190827;8472.068072511895;8793.120687931156 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,947 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1447333286795__endTimestamp 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,803 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4664.29 Median:4795.23 stddev:477.21 (10.0%) stddev-sans-first:452.32 05:01:26 INFO - 2015-11-12 05:01:26,804 DEBUG : BROWSER_OUTPUT: Values: 2670.9 2750.7 2761.3 2763.4 2780.5 4583.8 4678.5 4735.2 4767.7 4823.6 4691.6 4729.7 4788.7 4789.6 4797.9 4325.5 4379.1 4401.6 4485.4 4492.2 4223.8 4427.7 4450.0 4480.6 4538.2 4304.5 4344.3 4388.3 4395.3 4429.4 4372.6 4426.6 4430.0 4439.4 4476.0 4167.9 4417.6 4428.6 4432.6 4471.7 4522.5 4603.4 4621.4 4664.0 4675.1 5023.1 5030.9 5054.8 5066.1 5092.5 4868.7 4996.7 5055.9 5061.5 5077.1 4649.6 4688.0 4713.1 4734.8 4766.5 5209.3 5235.6 5236.6 5238.3 5277.5 4797.3 4912.6 5028.5 5031.0 5031.8 4943.9 5011.5 5019.4 5049.9 5052.6 5010.9 5084.3 5087.9 5096.9 5137.1 4818.8 4950.7 5048.4 5056.0 5056.6 4125.7 4182.1 4194.8 4216.5 4218.5 3661.2 3666.6 3677.4 3694.8 3727.7 4133.8 4312.9 4315.4 4321.9 4354.3 4884.2 4983.7 5023.3 5031.3 5073.0 4294.9 4354.8 4366.5 4369.9 4410.4 4396.8 4517.0 4518.3 4528.0 4532.5 4731.1 4739.5 4750.7 4850.7 4895.6 5061.9 5064.4 5074.0 5078.7 5125.5 4641.0 4779.4 4795.3 4818.5 4850.2 4874.5 4904.4 4959.8 4962.6 4995.3 5045.7 5077.1 5089.1 5099.2 5114.4 4701.6 4931.8 4943.1 4943.7 4976.3 4751.9 4776.5 4821.0 4847.6 4859.0 4827.1 4827.7 4830.3 4841.5 4873.2 4803.2 4941.8 4959.1 4966.2 5009.8 4756.1 4795.2 4818.7 4837.8 4869.2 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43057.91 Median:32336.35 stddev:71147.85 (220.0%) stddev-sans-first:71275.84 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: Values: 548.0 576.2 576.8 586.8 603.3 28160.0 36868.0 37558.8 37638.2 37718.2 39912.0 40647.4 40788.2 40843.4 40972.8 7029.6 7152.6 7740.7 7896.6 7900.5 9922.1 10174.6 10175.6 10181.9 10186.3 10058.5 10189.4 10191.4 10193.5 10197.5 7210.5 7382.7 10023.2 10159.3 10474.4 9891.1 10012.5 10013.3 10024.1 10028.3 38168.0 38776.6 38791.8 38796.8 38833.0 2487.8 2510.8 2694.1 2706.0 3070.7 29162.4 29316.9 29348.7 29637.9 31944.8 2439.6 2442.8 2452.5 2470.7 2491.4 218885.0 220872.0 221031.0 221463.0 221585.0 47298.3 55595.4 55885.0 55997.0 56047.7 47782.0 65588.0 66941.0 67120.0 67616.3 11819.1 11885.4 11890.3 11911.0 12098.0 9408.4 9525.9 9544.7 9549.3 9561.2 18907.3 19143.4 19173.0 19181.7 19243.4 7577.5 7630.9 7860.7 7872.1 7897.2 828.7 845.5 948.7 969.0 994.8 25797.0 26134.7 26470.6 26487.4 29830.6 933.8 940.8 1005.5 1036.0 1037.2 13676.8 13778.9 14000.4 14035.7 14036.9 325656.0 329243.0 331598.0 332589.0 332927.0 45477.5 45951.8 45955.5 46085.3 46190.5 1192.9 1204.3 1221.3 1223.0 1227.9 25033.9 25575.4 26284.5 26839.0 29875.3 41725.4 42179.4 42406.6 42469.0 42494.6 250104.0 252623.0 252754.0 252928.0 253106.0 23987.5 24413.1 28111.6 28713.3 29375.0 33737.8 33809.2 44003.3 45621.5 45786.8 34293.8 34683.5 34813.7 35302.3 37002.3 28550.8 31411.4 33795.5 34646.5 34774.8 31249.7 32261.5 32411.2 32478.8 32526.3 29055.6 31369.0 33096.8 35240.3 35979.8 23904.3 24256.8 24432.8 24523.3 24534.3 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21491.51 Median:441.90 stddev:62168.19 (14068.3%) stddev-sans-first:62322.29 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: Values: 330.9 331.9 331.9 334.8 335.5 9466.1 9754.5 11142.4 15149.2 15709.8 10128.6 10444.8 10467.9 10490.2 10927.1 4054.5 4153.4 4158.9 4159.4 4161.8 3190.4 3282.5 4064.3 6203.8 6526.8 6206.4 6425.2 6474.5 6505.3 6516.6 6423.4 6432.2 6451.5 6465.6 6465.7 5994.7 6111.4 6122.6 6172.3 6186.1 19349.2 19485.5 20016.6 20705.5 21147.2 1812.8 1851.3 1864.4 1897.6 1971.9 13324.2 13756.4 13779.2 14015.9 14171.8 1885.2 1906.1 1908.1 1943.6 1966.2 59931.0 61149.0 61817.0 62390.7 63075.7 14984.8 15589.3 15602.5 15687.8 15691.8 22827.5 22845.5 22983.4 23068.9 23104.4 7270.4 7917.6 8376.8 8379.4 8437.5 6955.8 6968.1 6997.4 7020.2 7035.4 6442.3 7428.9 7592.2 7593.6 7600.6 1074.5 1081.4 1093.9 1100.6 2071.4 416.4 424.5 433.9 449.9 490.2 9837.3 10887.9 10945.6 11037.3 11364.7 455.6 455.8 458.6 465.3 474.0 6115.4 6214.9 6215.5 6215.6 6220.3 119460.0 120419.4 472323.0 475105.0 477922.0 68029.3 69387.3 70342.9 70416.0 70427.6 513.1 526.2 526.8 527.0 527.7 10335.2 10372.9 10397.3 10488.3 10517.6 29062.4 29700.7 29770.0 30142.4 30634.8 35457.9 36069.3 38841.6 38956.8 38971.6 5614.6 6161.6 6246.8 6247.6 6268.5 11370.1 11489.0 11527.5 11548.6 11583.6 10016.3 10039.7 10338.5 10395.2 10448.2 8442.8 8448.2 9661.8 9911.1 10114.2 9214.4 9243.2 9349.6 9359.4 9492.0 6051.1 6055.5 6065.9 6066.6 6089.2 9403.4 9404.0 9503.6 9593.3 9753.9 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,805 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4869.78 Median:5777.49 stddev:2561.64 (44.3%) stddev-sans-first:2554.02 05:01:26 INFO - 2015-11-12 05:01:26,806 DEBUG : BROWSER_OUTPUT: Values: 1205.1 1322.0 1364.4 1445.3 1677.4 6073.5 6684.8 6851.0 6933.2 6935.2 6851.4 6971.7 6982.4 6986.1 6994.1 1744.5 1779.9 1895.4 1917.8 1991.9 2045.9 2048.4 2050.2 2050.8 2051.8 1985.5 2015.6 2042.5 2042.7 2047.1 1969.6 1981.9 2020.9 2027.5 2029.5 2048.7 2074.5 2078.0 2078.7 2079.4 7079.8 7104.1 7156.5 7163.2 7172.7 4047.4 4094.9 4111.6 4115.2 4115.7 2329.9 2519.7 2653.2 2662.8 2684.3 768.5 800.8 818.0 827.2 840.0 9169.8 9238.8 9327.6 9333.3 9341.8 3836.7 3845.3 3883.6 3905.7 3917.9 8099.9 8158.5 8181.6 8182.2 8191.2 4150.9 4160.9 4169.3 4175.9 4188.8 3733.0 3739.9 3747.5 3757.9 3759.5 3345.3 3381.6 3386.8 3390.6 3433.1 1074.9 1085.1 1086.3 1086.8 1093.2 1118.2 1131.7 1171.3 1173.2 1192.4 6571.7 6609.0 6618.1 6629.8 6649.5 400.5 403.1 405.9 408.2 409.2 5153.2 5166.7 5181.8 5219.0 5220.3 8257.3 8394.7 8420.4 8443.4 8645.2 8492.1 8551.8 8558.1 8576.9 8587.0 6310.1 6641.5 6669.5 6738.3 6745.2 6530.3 6600.2 6630.9 6637.7 6640.6 7425.4 7486.1 7531.4 7539.1 7556.2 7545.7 7557.3 7666.3 7698.7 7736.7 6292.7 6369.1 6375.9 6379.5 6395.2 6692.8 6728.3 6739.6 6776.1 6792.4 6383.5 6427.0 6465.2 6510.1 6598.7 6360.6 6371.3 6468.9 6471.7 6479.4 5488.5 5742.6 5743.4 5753.4 5765.9 5744.3 5774.9 5780.1 5786.4 5810.1 5440.1 5713.8 5745.7 5760.1 5782.2 05:01:26 INFO - 2015-11-12 05:01:26,807 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,807 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4582.10 Median:5053.89 stddev:1319.62 (26.1%) stddev-sans-first:1283.60 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: Values: 301.2 307.8 311.9 315.2 317.8 5247.2 5248.4 5256.6 5263.2 5285.4 5008.1 5083.6 5093.4 5166.2 5193.6 4082.5 4083.0 4096.9 4098.1 4105.1 3932.0 4070.7 4092.3 4092.6 4097.4 3948.7 3999.7 4040.0 4066.1 4070.3 4052.9 4054.0 4062.1 4069.8 4072.9 3605.3 3606.0 3606.5 3606.8 3610.6 4997.4 5003.8 5006.3 5009.9 5024.2 4590.5 4637.5 4685.9 4710.5 4723.6 5491.8 5497.0 5497.4 5505.5 5510.4 3958.5 3958.6 3962.5 3962.8 3963.9 5744.0 5760.3 5764.6 5775.7 5787.5 3916.1 4008.6 4015.3 4029.5 4073.3 4071.1 4072.0 4073.6 4075.2 4080.5 4633.4 4634.6 4634.7 4637.3 4641.7 5464.7 5498.0 5501.2 5513.9 5525.2 1454.7 1482.1 1501.2 1502.2 1505.0 1017.6 1037.1 1048.3 1054.7 1059.2 4819.7 4825.1 4826.6 4833.1 4834.4 5697.0 5712.8 5714.7 5717.7 5721.6 4661.4 4722.7 4740.2 4793.7 4818.9 3106.1 3107.5 3119.0 3134.9 3150.8 5305.3 5341.9 5356.3 5357.7 5358.9 5820.9 5828.0 5829.7 5832.0 5835.6 5180.0 5437.6 5437.8 5437.9 5446.5 5762.8 5764.5 5764.7 5766.3 5770.7 5633.8 5637.7 5643.0 5645.7 5646.2 5294.6 5392.4 5429.1 5430.9 5438.4 3955.1 4018.7 4021.6 4025.8 4027.1 5746.2 5746.4 5746.6 5765.8 5770.4 5540.6 5541.7 5552.4 5555.2 5558.5 5348.7 5444.1 5446.9 5448.8 5503.2 5371.6 5375.2 5375.4 5375.8 5377.9 5480.7 5509.6 5515.3 5521.7 5524.0 5269.2 5366.6 5380.4 5383.1 5387.9 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12051.51 Median:55081.14 stddev:14688.75 (26.7%) stddev-sans-first:14705.19 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: Values: 694.8 708.5 716.0 717.2 722.8 11050.9 11462.8 11471.5 11479.3 11493.1 11619.2 11768.8 11858.3 11858.3 11869.7 601.9 615.8 781.0 801.8 804.5 773.7 782.5 792.5 793.0 793.0 832.3 837.0 837.4 838.2 838.5 643.3 659.7 821.3 835.1 847.8 605.3 606.7 609.9 611.3 612.9 11100.1 11206.0 11210.5 11243.1 11281.0 9450.5 10333.8 10538.4 11111.0 11439.5 7596.5 7664.8 7701.8 7829.7 8671.0 2968.8 2996.6 3074.7 3114.5 3184.1 42505.6 42554.1 42690.8 42710.4 42930.6 7974.0 8193.4 8199.4 8222.6 8255.9 13154.2 13205.1 13208.0 13211.3 13219.0 6250.2 6260.7 6297.7 6410.3 6431.5 3418.0 3544.8 3610.4 3612.3 3620.1 2645.3 2696.4 2698.1 2699.1 2704.5 378.8 384.3 488.9 497.2 504.3 388.4 400.8 466.3 511.6 544.7 6475.4 6607.9 6986.7 7719.6 7763.5 410.4 423.0 429.5 496.2 506.0 3243.0 3250.1 3258.6 3263.2 3267.8 54904.7 54987.0 55175.3 55241.7 55396.7 44417.8 44544.0 44613.3 45734.0 46055.3 41609.4 42161.4 42459.8 42476.4 42794.4 7229.2 7341.1 7530.7 7559.1 7663.0 32494.5 32527.0 33370.7 33395.2 33853.8 38807.6 39203.4 39667.8 41313.8 41835.6 6175.8 6414.2 6541.9 6611.5 6615.7 10092.6 10367.8 10403.4 10445.8 10562.2 8941.3 9024.7 9304.8 9375.3 9673.0 8816.0 8935.0 9201.7 9315.3 9336.5 9387.5 9545.8 9596.2 9656.4 9745.5 8341.6 8542.8 8581.4 8676.7 8696.3 8258.6 8434.5 8442.2 8472.1 8793.1 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:26 INFO - 2015-11-12 05:01:26,808 DEBUG : BROWSER_OUTPUT: 05:01:27 INFO - 2015-11-12 05:01:27,522 INFO : Browser exited with error code: 0 05:01:27 INFO - 2015-11-12 05:01:27,538 INFO : Completed test dromaeo_css (00:18:38) 05:01:27 INFO - 2015-11-12 05:01:27,538 INFO : Starting test kraken 05:01:27 INFO - 2015-11-12 05:01:27,538 DEBUG : operating with platform_type : linux_ 05:01:27 INFO - 2015-11-12 05:01:27,539 INFO : Initialising browser for kraken test... 05:01:27 INFO - 2015-11-12 05:01:27,544 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0jzz6/profile http://localhost:41757/getInfo.html 05:01:31 INFO - 2015-11-12 05:01:31,466 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:01:31 INFO - 2015-11-12 05:01:31,466 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:01:31 INFO - 2015-11-12 05:01:31,466 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:01:31 INFO - 2015-11-12 05:01:31,466 DEBUG : BROWSER_OUTPUT: __metrics 05:01:31 INFO - 2015-11-12 05:01:31,649 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:32 INFO - 2015-11-12 05:01:32,914 INFO : Browser initialized. 05:01:32 INFO - 2015-11-12 05:01:32,914 INFO : Running cycle 1/1 for kraken test... 05:01:32 INFO - 2015-11-12 05:01:32,915 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0jzz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:01:44 INFO - 2015-11-12 05:01:44,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 139087872 05:01:44 INFO - 2015-11-12 05:01:44,781 DEBUG : BROWSER_OUTPUT: 05:01:47 INFO - 2015-11-12 05:01:47,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41757/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:47 INFO - 2015-11-12 05:01:47,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 179765248 05:01:47 INFO - 2015-11-12 05:01:47,958 DEBUG : BROWSER_OUTPUT: 05:01:50 INFO - 2015-11-12 05:01:50,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41757/tests/kraken/driver.html?testName=audio-dft) 05:01:51 INFO - 2015-11-12 05:01:51,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 171393024 05:01:51 INFO - 2015-11-12 05:01:51,264 DEBUG : BROWSER_OUTPUT: 05:01:54 INFO - 2015-11-12 05:01:54,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41757/tests/kraken/driver.html?testName=audio-fft) 05:01:54 INFO - 2015-11-12 05:01:54,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 149987328 05:01:54 INFO - 2015-11-12 05:01:54,797 DEBUG : BROWSER_OUTPUT: 05:01:56 INFO - 2015-11-12 05:01:56,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41757/tests/kraken/driver.html?testName=audio-oscillator) 05:01:57 INFO - 2015-11-12 05:01:57,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 153354240 05:01:57 INFO - 2015-11-12 05:01:57,423 DEBUG : BROWSER_OUTPUT: 05:01:59 INFO - 2015-11-12 05:01:59,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:00 INFO - 2015-11-12 05:02:00,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 153923584 05:02:00 INFO - 2015-11-12 05:02:00,233 DEBUG : BROWSER_OUTPUT: 05:02:03 INFO - 2015-11-12 05:02:03,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41757/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:03 INFO - 2015-11-12 05:02:03,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 155156480 05:02:03 INFO - 2015-11-12 05:02:03,809 DEBUG : BROWSER_OUTPUT: 05:02:07 INFO - 2015-11-12 05:02:07,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41757/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:07 INFO - 2015-11-12 05:02:07,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 156987392 05:02:07 INFO - 2015-11-12 05:02:07,821 DEBUG : BROWSER_OUTPUT: 05:02:10 INFO - 2015-11-12 05:02:10,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41757/tests/kraken/driver.html?testName=json-parse-financial) 05:02:11 INFO - 2015-11-12 05:02:11,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 156147712 05:02:11 INFO - 2015-11-12 05:02:11,270 DEBUG : BROWSER_OUTPUT: 05:02:13 INFO - 2015-11-12 05:02:13,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:13 INFO - 2015-11-12 05:02:13,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 165724160 05:02:13 INFO - 2015-11-12 05:02:13,618 DEBUG : BROWSER_OUTPUT: 05:02:15 INFO - 2015-11-12 05:02:15,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:16 INFO - 2015-11-12 05:02:16,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 167485440 05:02:16 INFO - 2015-11-12 05:02:16,038 DEBUG : BROWSER_OUTPUT: 05:02:18 INFO - 2015-11-12 05:02:18,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:18 INFO - 2015-11-12 05:02:18,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 178798592 05:02:18 INFO - 2015-11-12 05:02:18,723 DEBUG : BROWSER_OUTPUT: 05:02:21 INFO - 2015-11-12 05:02:21,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:21 INFO - 2015-11-12 05:02:21,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 181358592 05:02:21 INFO - 2015-11-12 05:02:21,837 DEBUG : BROWSER_OUTPUT: 05:02:24 INFO - 2015-11-12 05:02:24,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:25 INFO - 2015-11-12 05:02:25,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 181096448 05:02:25 INFO - 2015-11-12 05:02:25,014 DEBUG : BROWSER_OUTPUT: 05:02:26 INFO - 2015-11-12 05:02:26,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41757/tests/kraken/driver.html?testName=ai-astar) 05:02:27 INFO - 2015-11-12 05:02:27,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 240263168 05:02:27 INFO - 2015-11-12 05:02:27,018 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;114;106;114;112;112;101;112;110;103 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;158;174;132;153;152;130;172;131 05:02:27 INFO - 2015-11-12 05:02:27,022 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;162;162;161;162;161;163;163;163 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;79;94;73;72;72;98;94;72 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;134;91;93;92;124;91;91;134 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;110;110;111;111;113;111 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;147;147;147;146 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;96;95;95;95;96 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;71;72;72;71;72;80;69;69 05:02:27 INFO - 2015-11-12 05:02:27,023 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;66;68;67;66;67;67;68;67 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;83;85;85;85;84;84;85;88 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;125;119;125;119;130;127;127;120 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;139;145;144;144;136;145;163;151;137 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;68;68;71;70;68;69;69;68 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:02:27 INFO - 2015-11-12 05:02:27,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 05:02:27 INFO - 2015-11-12 05:02:27,025 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:02:27 INFO - 2015-11-12 05:02:27,025 DEBUG : BROWSER_OUTPUT: __startTimestamp1447333347019__endTimestamp 05:02:27 INFO - 2015-11-12 05:02:27,025 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:112.00 stddev:4.55 (4.1%) stddev-sans-first:4.82 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: Values: 109.0 114.0 106.0 114.0 112.0 112.0 101.0 112.0 110.0 103.0 05:02:27 INFO - 2015-11-12 05:02:27,028 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.50 stddev:17.06 (11.1%) stddev-sans-first:17.98 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 158.0 174.0 132.0 153.0 152.0 130.0 172.0 131.0 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 162.0 162.0 161.0 162.0 161.0 163.0 163.0 163.0 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:76.00 stddev:10.83 (14.3%) stddev-sans-first:11.19 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 79.0 94.0 73.0 72.0 72.0 98.0 94.0 72.0 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:91.00 stddev:19.09 (21.0%) stddev-sans-first:19.81 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 134.0 91.0 93.0 92.0 124.0 91.0 91.0 134.0 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:1.17 (1.1%) stddev-sans-first:1.24 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 110.0 110.0 111.0 111.0 113.0 111.0 05:02:27 INFO - 2015-11-12 05:02:27,029 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:72.00 stddev:3.12 (4.3%) stddev-sans-first:3.31 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 72.0 72.0 71.0 72.0 80.0 69.0 69.0 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 68.0 67.0 66.0 67.0 67.0 68.0 67.0 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.58 (1.9%) stddev-sans-first:1.67 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 83.0 85.0 85.0 85.0 84.0 84.0 85.0 88.0 05:02:27 INFO - 2015-11-12 05:02:27,030 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:125.00 stddev:3.80 (3.0%) stddev-sans-first:3.91 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 125.0 119.0 125.0 119.0 130.0 127.0 127.0 120.0 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:145.00 stddev:8.18 (5.6%) stddev-sans-first:8.24 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: Values: 153.0 139.0 145.0 144.0 144.0 136.0 145.0 163.0 151.0 137.0 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 05:02:27 INFO - 2015-11-12 05:02:27,031 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 68.0 68.0 71.0 70.0 68.0 69.0 69.0 68.0 05:02:27 INFO - 2015-11-12 05:02:27,032 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:02:27 INFO - 2015-11-12 05:02:27,032 DEBUG : BROWSER_OUTPUT: 05:02:27 INFO - 2015-11-12 05:02:27,950 INFO : Browser exited with error code: 0 05:02:28 INFO - 2015-11-12 05:02:28,004 INFO : Completed test kraken (00:01:00) 05:02:28 INFO - 2015-11-12 05:02:28,004 INFO : Starting test v8_7 05:02:28 INFO - 2015-11-12 05:02:28,004 DEBUG : operating with platform_type : linux_ 05:02:28 INFO - 2015-11-12 05:02:28,004 INFO : Initialising browser for v8_7 test... 05:02:28 INFO - 2015-11-12 05:02:28,010 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyO7wg_/profile http://localhost:41757/getInfo.html 05:02:31 INFO - 2015-11-12 05:02:31,984 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:02:31 INFO - 2015-11-12 05:02:31,984 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:02:31 INFO - 2015-11-12 05:02:31,984 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:02:31 INFO - 2015-11-12 05:02:31,984 DEBUG : BROWSER_OUTPUT: __metrics 05:02:32 INFO - 2015-11-12 05:02:32,141 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:33 INFO - 2015-11-12 05:02:33,279 INFO : Browser initialized. 05:02:33 INFO - 2015-11-12 05:02:33,280 INFO : Running cycle 1/1 for v8_7 test... 05:02:33 INFO - 2015-11-12 05:02:33,280 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyO7wg_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:02:45 INFO - 2015-11-12 05:02:45,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 05:02:45 INFO - 2015-11-12 05:02:45,267 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41757/tests/v8_7/run.html (next: http://localhost:41757/tests/v8_7/run.html) 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 441716736 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: |0;Richards;170.88174982911826 05:03:06 INFO - 2015-11-12 05:03:06,988 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.8045336306206 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |5;Earley;799.3605115907275 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |8;Splay;605.1995163240629 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1447333386981__endTimestamp 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,989 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.88 Median:170.88 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 170.9 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.80 Median:185.80 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 185.8 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 279.4 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 5035.2 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 1980.2 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,990 DEBUG : BROWSER_OUTPUT: Values: 799.4 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: Values: 11964.3 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: Values: 26076.9 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.20 Median:605.20 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: Values: 605.2 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:03:06 INFO - 2015-11-12 05:03:06,991 DEBUG : BROWSER_OUTPUT: 05:03:07 INFO - 2015-11-12 05:03:07,922 INFO : Browser exited with error code: 0 05:03:07 INFO - 2015-11-12 05:03:07,936 INFO : Completed test v8_7 (00:00:39) 05:03:07 INFO - 2015-11-12 05:03:07,971 INFO : Completed test suite (00:20:18) 05:03:07 INFO - 2015-11-12 05:03:07,971 DEBUG : Working with test: dromaeo_css 05:03:07 INFO - 2015-11-12 05:03:07,971 DEBUG : Generating results file: dromaeo_css 05:03:07 INFO - 2015-11-12 05:03:07,972 DEBUG : Working with test: kraken 05:03:07 INFO - 2015-11-12 05:03:07,972 DEBUG : Generating results file: kraken 05:03:07 INFO - 2015-11-12 05:03:07,973 INFO : javascript benchmark 05:03:07 INFO - 2015-11-12 05:03:07,973 DEBUG : Working with test: v8_7 05:03:07 INFO - 2015-11-12 05:03:07,973 DEBUG : Generating results file: v8_7 05:03:07 INFO - 2015-11-12 05:03:07,973 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:08 INFO - 2015-11-12 05:03:08,032 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:03:08 INFO - 2015-11-12 05:03:08,032 DEBUG : process_Request line: dromaeo_css 6096.47 graph.html#tests=[[72,94,35]] 05:03:08 INFO - 2015-11-12 05:03:08,032 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:08 INFO - 2015-11-12 05:03:08,066 DEBUG : process_Request line: kraken 1517.30 graph.html#tests=[[232,94,35]] 05:03:08 INFO - 2015-11-12 05:03:08,066 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:08 INFO - 2015-11-12 05:03:08,098 DEBUG : process_Request line: v8_7 19880.11 graph.html#tests=[[230,94,35]] 05:03:08 INFO - 2015-11-12 05:03:08,100 INFO : javascript benchmark 05:03:08 INFO - 2015-11-12 05:03:08,104 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.92554175310556, 331.8573013604149, 331.86891177984694, 334.81919763327807, 335.5453360696258, 9466.100720431565, 9754.512274386288, 11142.442877856105, 15149.166795826226, 15709.84290157098, 10128.645497407591, 10444.791104177912, 10467.947660261689, 10490.213234007442, 10927.125829933606, 4054.4931883514487, 4153.376993450991, 4158.896027599304, 4159.438475805758, 4161.791910404483, 3190.425723369804, 3282.4912138618433, 4064.309067458539, 6203.751849925998, 6526.836829079287, 6206.37936206378, 6425.164728585278, 6474.514411419139, 6505.316941721122, 6516.641584712839, 6423.421892029716, 6432.228132624068, 6451.548391612566, 6465.644389558573, 6465.709043093025, 5994.670293133876, 6111.449969502766, 6122.602030868024, 6172.321044685081, 6186.072089186613, 19349.226030958744, 19485.512862178417, 20016.59966800656, 20705.482362940897, 21147.15411383543, 1812.8459080978132, 1851.3150134450339, 1864.4033909149077, 1897.5920177161977, 1971.8521110916738, 13324.200547967055, 13756.449742010307, 13779.242141682204, 14015.859841401558, 14171.78742318866, 1885.236479225902, 1906.1231833356674, 1908.055512521311, 1943.6112777444569, 1966.1643801384498, 59931.0, 61149.0, 61817.0, 62390.68804655993, 63075.68462157706, 14984.775228371584, 15589.298481568356, 15602.453914112952, 15687.843121568867, 15691.843081569266, 22827.543449130924, 22845.543089138126, 22983.42541436444, 23068.884655576614, 23104.4223894404, 7270.418366530665, 7917.643706033243, 8376.790580235422, 8379.413441059067, 8437.451565648213, 6955.791326260221, 6968.0941477607585, 6997.440204783605, 7020.157581090302, 7035.366816986496, 6442.323556026549, 7428.888566671504, 7592.240775922363, 7593.620318984029, 7600.567818298202, 1074.4681382715605, 1081.4430568257353, 1093.8742044664807, 1100.6312885183554, 2071.4200023993308, 416.4149370134965, 424.54573606241024, 433.93707912352534, 449.869537834031, 490.2107606753125, 9837.262205334628, 10887.891121088845, 10945.616903408343, 11037.337759734442, 11364.659060228207, 455.55583306276117, 455.84956964201734, 458.5689451915256, 465.3368949247309, 474.0306074078518, 6115.388461153849, 6214.937850621526, 6215.471684906744, 6215.564910456224, 6220.284667263232, 119460.0, 120419.39790301168, 472323.0, 475105.0, 477922.0, 68029.31970680329, 69387.30612693909, 70342.9448558272, 70416.0, 70427.64786176036, 513.0585375835309, 526.1870410216225, 526.7682219823265, 526.9920951185735, 527.6833899660173, 10335.17318614524, 10372.896271037192, 10397.272190946864, 10488.31825931312, 10517.631882884063, 29062.41875162527, 29700.702992969793, 29770.0, 30142.397152057274, 30634.84682576573, 35457.93626191218, 36069.27861442809, 38841.6115838838, 38956.80521597374, 38971.6102838968, 5614.578906581941, 6161.5686901918225, 6246.843828904313, 6247.562670613013, 6268.498520118288, 11370.090392768394, 11489.0, 11527.538898443969, 11548.59579914699, 11583.5945741902, 10016.298859079794, 10039.69880903574, 10338.534765935401, 10395.220358472994, 10448.216383771096, 8442.831143376976, 8448.23965843077, 9661.758456038375, 9911.10800028001, 10114.241431892491, 9214.401063930824, 9243.2143267823, 9349.579268932779, 9359.438433694, 9492.0, 6051.062085376773, 6055.515558755377, 6065.939340606714, 6066.636001839904, 6089.208402907594, 9403.43579385239, 9404.0, 9503.61985520599, 9593.32846700752, 9753.9024609753], "dojo.html": [2670.919872403828, 2750.669919609647, 2761.282066662667, 2763.4334961332916, 2780.471710375028, 4583.839565615204, 4678.508756580557, 4735.171345014626, 4767.713937163769, 4823.638227132966, 4691.601213896823, 4729.692569982949, 4788.688735232207, 4789.568938795508, 4797.944452220506, 4325.52419233884, 4379.080393117433, 4401.603855652983, 4485.3944717463055, 4492.191405547001, 4223.809928553223, 4427.690061695683, 4449.955500444987, 4480.641548676098, 4538.160440318552, 4304.5480224576595, 4344.304911214223, 4388.27593447084, 4395.318725597537, 4429.379886815848, 4372.5627437256335, 4426.62373698236, 4430.0, 4439.422875026258, 4475.977620111878, 4167.874963751093, 4417.602415782595, 4428.645708343325, 4432.601065904084, 4471.6646251531265, 4522.479914809806, 4603.447586289667, 4621.4223222097235, 4663.976680116578, 4675.111728771557, 5023.120953833065, 5030.949690503085, 5054.848354549369, 5066.113430149709, 5092.541671249568, 4868.707877527359, 4996.650234483587, 5055.9241611375855, 5061.493850614946, 5077.136886729265, 4649.5815376616265, 4687.976560117212, 4713.057388522309, 4734.763261836894, 4766.451858036301, 5209.29674493946, 5235.633505654644, 5236.607254455931, 5238.3190185276435, 5277.498637629419, 4797.328374027639, 4912.606991440676, 5028.547430731179, 5031.018951304461, 5031.7987280509105, 4943.8516844494725, 5011.5489605935645, 5019.372578427697, 5049.873753156127, 5052.595792336604, 5010.949890501121, 5084.262781896604, 5087.949120508822, 5096.898062038813, 5137.075326441276, 4818.759062046884, 4950.6782059166035, 5048.3941926969, 5056.0, 5056.595472362203, 4125.66994640428, 4182.121754431542, 4194.790260486963, 4216.451861258078, 4218.451601291812, 3661.2494438640015, 3666.5966743658178, 3677.3748462761396, 3694.7598406103516, 3727.7204209684382, 4133.772642504691, 4312.913741725148, 4315.395844581761, 4321.891952701208, 4354.259775838115, 4884.1941079722155, 4983.651144419856, 5023.34696489454, 5031.320771695774, 5073.0, 4294.89262768427, 4354.804033818486, 4366.541513141075, 4369.934450983238, 4410.360497727876, 4396.802143903532, 4516.977415112903, 4518.299663552155, 4528.0, 4532.524084971096, 4731.148393289172, 4739.502352252964, 4750.667453278237, 4850.660453768202, 4895.583875370633, 5061.9493805061475, 5064.417591976822, 5074.0, 5078.669886457368, 5125.461826508163, 4640.9535904640525, 4779.402574678165, 4795.304680821331, 4818.518148185153, 4850.151223535938, 4874.488178741323, 4904.411470623548, 4959.752012399294, 4962.5533701967, 4995.325631039763, 5045.747712614281, 5077.111505486599, 5089.109405854035, 5099.23511473282, 5114.360704911886, 4701.600363968964, 4931.802727890844, 4943.060818444484, 4943.728094954812, 4976.32819569368, 4751.904961900674, 4776.522347765195, 4821.0, 4847.61219102478, 4858.975705121452, 4827.131116398941, 4827.686200396963, 4830.275458681226, 4841.491643377535, 4873.220284754564, 4803.183458811941, 4941.75291235444, 4959.132151873336, 4966.230234313687, 5009.774560144875, 4756.096341695067, 4795.232762757942, 4818.734969576707, 4837.830675926326, 4869.245266983623], "mootools.html": [1205.1323047405876, 1322.0018885741265, 1364.399664147775, 1445.342369222004, 1677.3626022111603, 6073.544484163689, 6684.832879178017, 6851.0, 6933.202681691607, 6935.1677798664105, 6851.383375496204, 6971.651417429121, 6982.441404687625, 6986.091808064957, 6994.125734283215, 1744.5289771761616, 1779.8843075200136, 1895.3650527073412, 1917.769867615888, 1991.8804871707744, 2045.9181632734746, 2048.3752455501067, 2050.2209160518983, 2050.846186536008, 2051.7640471345762, 1985.5433250352428, 2015.6472617291915, 2042.4587484316594, 2042.7446569178853, 2047.119738512439, 1969.6454638165123, 1981.920723171086, 2020.8989550522415, 2027.5032617008853, 2029.4926268432819, 2048.7131801547794, 2074.4502706782714, 2078.044099714133, 2078.7089807426973, 2079.396974877284, 7079.823004424879, 7104.147502299706, 7156.499045066847, 7163.1762347330205, 7172.713091476335, 4047.352423612208, 4094.877153685394, 4111.568285330057, 4115.1975364803875, 4115.650169735576, 2329.871857047862, 2519.748025197484, 2653.230563136688, 2662.773664238542, 2684.2618279973162, 768.5158350239369, 800.7877912353231, 818.0224631565281, 827.1563005734117, 840.0297656207091, 9169.770755731093, 9238.769030774218, 9327.626894924195, 9333.253339732873, 9341.813163736755, 3836.731428799957, 3845.307844587945, 3883.5533913599734, 3905.726599138033, 3917.941230881539, 8099.878501822477, 8158.510489370657, 8181.590920454072, 8182.22268884455, 8191.221833925768, 4150.896227594274, 4160.895977600584, 4169.2703776838935, 4175.937360939588, 4188.8115034822895, 3733.029412352808, 3739.9252014959548, 3747.45661879026, 3757.887263382103, 3759.49246851677, 3345.347657206821, 3381.560397148355, 3386.813725245135, 3390.627031026585, 3433.141714571357, 1074.919381046409, 1085.1210519479248, 1086.326477583903, 1086.8261078227604, 1093.1637297467444, 1118.2340097033557, 1131.6605018494583, 1171.3147808531933, 1173.221201287263, 1192.350169157811, 6571.737130514822, 6609.0, 6618.073469714244, 6629.801105966829, 6649.468042556584, 400.51537639456586, 403.1372862075161, 405.904612416082, 408.19585416728995, 409.2224772931454, 5153.201253805666, 5166.689998600096, 5181.792728290826, 5219.0, 5220.347456567929, 8257.256846883689, 8394.748157555283, 8420.410571259952, 8443.366747493963, 8645.178708022728, 8492.108328625529, 8551.828963420698, 8558.058613552505, 8576.871346929802, 8586.957065214634, 6310.148130002391, 6641.50188735837, 6669.533132680665, 6738.258791532928, 6745.156855393076, 6530.314316996837, 6600.2409722882485, 6630.867382652416, 6637.70130344126, 6640.634765087966, 7425.405967522477, 7486.064241969754, 7531.435142364454, 7539.132999704885, 7556.2443755624, 7545.660445280086, 7557.2820582044615, 7666.348360389429, 7698.730544430918, 7736.651850666621, 6292.653904035322, 6369.0764839099, 6375.936240637534, 6379.457746091634, 6395.232572091379, 6692.799216023527, 6728.259891411843, 6739.59562426256, 6776.051352810709, 6792.388685018372, 6383.521235907233, 6427.0, 6465.224173099258, 6510.0885875976455, 6598.736050558116, 6360.618362898056, 6371.267304260069, 6468.870622587616, 6471.741130354733, 6479.384458476437, 5488.533474654699, 5742.569307301886, 5743.396943321059, 5753.424657534213, 5765.913511297418, 5744.339400968942, 5774.9133762994425, 5780.075187969905, 5786.392428794916, 5810.070388737781, 5440.102383106743, 5713.771449141987, 5745.712714364348, 5760.0783874579865, 5782.2194003808945], "ext.html": [548.0249051044203, 576.2336092996316, 576.8327185116316, 586.8151532267335, 603.2519675602251, 28160.0, 36868.0, 37558.812205939, 37638.247235055285, 37718.24563508728, 39912.0, 40647.39028914569, 40788.184236315254, 40843.38734918978, 40972.79513602435, 7029.648517574126, 7152.570845749246, 7740.690372385098, 7896.644650990691, 7900.486468379566, 9922.057404546593, 10174.64388746394, 10175.643852465166, 10181.898181018207, 10186.337888037291, 10058.49707514625, 10189.439580823051, 10191.439470829102, 10193.490325483695, 10197.490125493732, 7210.531315464478, 7382.7046918123215, 10023.2482563808, 10159.339642923187, 10474.371537707762, 9891.109800117953, 10012.499375031291, 10013.299069065168, 10024.147947424404, 10028.298019138663, 38168.0, 38776.61223387758, 38791.806040969896, 38796.80601596974, 38833.0, 2487.838290511129, 2510.8367956082798, 2694.0840114361017, 2705.971730742325, 3070.6929307069113, 29162.41675166506, 29316.853415732785, 29348.706512934812, 29637.85181074081, 31944.840275798706, 2439.573074711936, 2442.829001969863, 2452.460458699083, 2470.700980294293, 2491.364702000996, 218885.0, 220872.0, 221031.0, 221462.9999999984, 221585.0, 47298.29052564214, 55595.44404555984, 55885.0, 55997.0, 56047.719761400935, 47782.0, 65588.0, 66941.0, 67120.0, 67616.323836761, 11819.054475641928, 11885.40572971348, 11890.28658280506, 11911.0, 12098.0, 9408.435493870253, 9525.857112143323, 9544.665936692183, 9549.283803714749, 9561.187299079516, 18907.29834314918, 19143.425697229104, 19173.0, 19181.712274315898, 19243.422697319103, 7577.507462014952, 7630.923690763132, 7860.7248746294745, 7872.134065252818, 7897.210278972057, 828.7389472316322, 845.4546817302928, 948.7390967483859, 968.951552422376, 994.7910938702809, 25797.0, 26134.738652613232, 26470.6029409559, 26487.41075535474, 29830.55254171189, 933.8272419602396, 940.7648087978006, 1005.5374527717186, 1035.989909837902, 1037.180627304436, 13676.794848077287, 13778.862211377958, 14000.36998335057, 14035.71928561423, 14036.859631403555, 325656.0, 329243.0, 331598.0, 332589.0, 332927.0, 45477.54522454733, 45951.77024114858, 45955.5404445958, 46085.30872036855, 46190.53809461863, 1192.928424294545, 1204.3015051270243, 1221.3465795799204, 1222.9999999999823, 1227.914046016788, 25033.87483062646, 25575.360615984748, 26284.474310514066, 26839.0, 29875.253118672208, 41725.37411938884, 42179.367309491, 42406.57593424026, 42469.0, 42494.575054249064, 250104.0, 252623.0, 252754.0, 252928.0, 253106.0, 23987.520249595258, 24413.145539906018, 28111.57832632553, 28713.28216794597, 29375.0, 33737.83131084329, 33809.154771129935, 44003.33994990142, 45621.54378456306, 45786.77106614446, 34293.82853085719, 34683.4797478033, 34813.65186348104, 35302.29395412026, 37002.259954801295, 28550.843457305575, 31411.37177256488, 33795.4930676045, 34646.480302794975, 34774.82612586921, 31249.68750312468, 32261.51607725933, 32411.18972025718, 32478.83760581182, 32526.349473009934, 29055.564166537097, 31369.0, 33096.83451582823, 35240.295194096485, 35979.820100900375, 23904.282871513882, 24256.75743242545, 24432.755672443047, 24523.264302070966, 24534.263972080866], "prototype.html": [301.2318587601617, 307.75994724115185, 311.89083820662773, 315.1506689471874, 317.84107946026984, 5247.239150323201, 5248.448912864142, 5256.579473642109, 5263.210518422238, 5285.418603953567, 5008.098542262392, 5083.5933125349975, 5093.439721630618, 5166.199239117934, 5193.610479214055, 4082.4896887889013, 4082.9795851020776, 4096.85661001865, 4098.139390727951, 4105.096878686684, 3931.9803400983096, 4070.715049946505, 4092.263392589333, 4092.570280120589, 4097.405876147956, 3948.6841052715713, 3999.7400168988925, 4040.030392705759, 4066.125782956664, 4070.308047631895, 4052.8854564994567, 4054.0270335119358, 4062.1469491406842, 4069.8168582413864, 4072.8574499892657, 3605.3330133925047, 3606.0, 3606.495090687306, 3606.801625910574, 3610.638936106395, 4997.42529609096, 5003.799848006075, 5006.349174607314, 5009.899802003976, 5024.19612861944, 4590.517995610479, 4637.489876113625, 4685.929711054337, 4710.458297295821, 4723.622110231207, 5491.780328786844, 5497.0, 5497.422770609069, 5505.504504594605, 5510.393856675762, 3958.4853968984135, 3958.604139586047, 3962.5046869141356, 3962.8018599069933, 3963.8810835674976, 5743.971280143614, 5760.337561180434, 5764.5676574257095, 5775.653460792366, 5787.50806181475, 3916.099297161669, 4008.6392224699334, 4015.297322968469, 4029.49631296088, 4073.287174744408, 4071.145059537471, 4071.959280407158, 4073.592640735962, 4075.2460794753065, 4080.5307389649975, 4633.397658304399, 4634.629229661619, 4634.698744581591, 4637.25803871379, 4641.651876109306, 5464.726763661801, 5498.037843377473, 5501.202325662756, 5513.917291240635, 5525.171224316385, 1454.7454195515743, 1482.0959214878915, 1501.2343704710677, 1502.1738044075714, 1504.9548513544391, 1017.6285655735603, 1037.1184493180888, 1048.3185929146116, 1054.7415883108688, 1059.163261023798, 4819.734914579662, 4825.059113472839, 4826.565609095198, 4833.130036593447, 4834.444038935497, 5696.971515142481, 5712.80005199816, 5714.657120572779, 5717.685527296038, 5721.5708821838525, 4661.440627124767, 4722.669413141047, 4740.170470167707, 4793.736344501086, 4818.855434336975, 3106.08370530694, 3107.502799552106, 3118.953215701766, 3134.9216269592985, 3150.8109513429267, 5305.283786688748, 5341.893162136736, 5356.276902618175, 5357.732113394315, 5358.946410535845, 5820.883582328414, 5828.038373668382, 5829.708514574254, 5831.9708401458565, 5835.620684655484, 5180.0, 5437.619366644297, 5437.782488700487, 5437.864053398696, 5446.509814116669, 5762.769489220552, 5764.538836893123, 5764.7405866736935, 5766.250387449605, 5770.711464426678, 5633.8309850704545, 5637.746301416528, 5643.040683083804, 5645.661260324394, 5646.181303711021, 5294.629375943647, 5392.379876314274, 5429.131338985743, 5430.891382172255, 5438.374586922397, 3955.129871428281, 4018.738781979162, 4021.5576286607866, 4025.818838152232, 4027.0536423940935, 5746.195532625352, 5746.3966283541295, 5746.62646927965, 5765.769369225184, 5770.422957704364, 5540.556755459635, 5541.667499950016, 5552.416996215339, 5555.194496797861, 5558.527525160407, 5348.705821179872, 5444.101723215784, 5446.891062178655, 5448.809291674773, 5503.2020357048805, 5371.5702743781185, 5375.247465354775, 5375.435579264277, 5375.784968601369, 5377.946220537745, 5480.698561579152, 5509.559235261089, 5515.283013208257, 5521.723913804213, 5523.950449414599, 5269.209618557247, 5366.570674345965, 5380.381256155592, 5383.111786555174, 5387.892242155213], "yui.html": [694.826293426643, 708.5040471669831, 716.0083284650759, 717.2289788477389, 722.7976166673327, 11050.889491105097, 11462.828057579132, 11471.541138354476, 11479.311241325526, 11493.138014648914, 11619.244749091304, 11768.7646247075, 11858.3477908715, 11858.3477908715, 11869.703257418569, 601.9036954087325, 615.8398816307747, 780.9648565814538, 801.7634797734682, 804.4610111225493, 773.7098588029489, 782.5148407987027, 792.5482474989259, 793.0364607002491, 793.0364607002491, 832.2800777327599, 836.9790755231137, 837.3719710217337, 838.2162677896156, 838.4591938199858, 643.3437893348781, 659.7492952677976, 821.2977903892146, 835.0605568735173, 847.8346722389136, 605.252513146264, 606.6633018674634, 609.8536351275707, 611.2909025530408, 612.8712970276247, 11100.111991040778, 11206.0, 11210.495527701272, 11243.100551955824, 11281.0, 9450.4802235877, 10333.79332413355, 10538.367697938149, 11111.000009999058, 11439.485223164978, 7596.468247222697, 7664.808379790494, 7701.807454813618, 7829.686812527492, 8670.956645216733, 2968.807027543224, 2996.625421822272, 3074.677158898306, 3114.5016797312323, 3184.060702092865, 42505.57494425047, 42554.1489170218, 42690.78654606707, 42710.35934460985, 42930.57069429297, 7974.0, 8193.426460147732, 8199.385046121564, 8222.62998165072, 8255.876161857577, 13154.21074735519, 13205.075644704779, 13208.0, 13211.273379964003, 13219.0, 6250.15622890913, 6260.655663938436, 6297.685115744194, 6410.326915673881, 6431.517636177306, 3417.965820341765, 3544.8227588620466, 3610.4403817408343, 3612.3317186320614, 3620.113072297304, 2645.3386653336665, 2696.4202696420366, 2698.123109989222, 2699.136276391575, 2704.4591081783724, 378.76138033039007, 384.30632707961837, 488.8509004753513, 497.1672448648499, 504.32672382369213, 388.41543477066836, 400.7815740421419, 466.2935652486418, 511.5728366813678, 544.6976927805027, 6475.384838440341, 6607.933920660732, 6986.685599148051, 7719.589194373464, 7763.534187948628, 410.386472224027, 422.97250678705785, 429.5382463851372, 496.201116202913, 505.95699365553605, 3242.9675703242665, 3250.1224669339144, 3258.5926759155104, 3263.2168279613197, 3267.820269885179, 54904.72547637236, 54987.0, 55175.275461435434, 55241.72379138159, 55396.72301638466, 44417.777911110235, 44544.0, 44613.33080003803, 45734.0, 46055.309170362474, 41609.37585936213, 42161.36757948633, 42459.78770106191, 42476.36285455721, 42794.35808462876, 7229.179852386294, 7341.119065712149, 7530.698772049276, 7559.092908850973, 7662.961685191538, 32494.512582311756, 32527.0, 33370.666293336755, 33395.1651208712, 33853.83073084619, 38807.6119238804, 39203.41194882136, 39667.80166099266, 41313.79343103265, 41835.58164418317, 6175.783847565313, 6414.198225221848, 6541.8691626166255, 6611.471082313499, 6615.702293396713, 10092.596296148073, 10367.792644147226, 10403.375797452178, 10445.843312350473, 10562.207834412604, 8941.329400295133, 9024.684136055206, 9304.767380815263, 9375.34372593912, 9672.95163524178, 8815.955920220358, 8935.0, 9201.723948281562, 9315.34792564514, 9336.486493242937, 9387.483688397204, 9545.761355966157, 9596.18432433251, 9656.420614763138, 9745.512724363613, 8341.624626891684, 8542.82914341722, 8581.442206256574, 8676.652933882575, 8696.304295656459, 8258.628361723857, 8434.451760635538, 8442.197991190827, 8472.068072511895, 8793.120687931156]}, "summary": {"lowerIsBetter": false, "suite": 6096.46773164324, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7376.85174474951, "unit": "ms", "value": 7376.85174474951}, "dojo.html": {"lowerIsBetter": false, "filtered": 4635.361618498022, "unit": "ms", "value": 4635.361618498022}, "mootools.html": {"lowerIsBetter": false, "filtered": 3912.0583421365386, "unit": "ms", "value": 3912.0583421365386}, "ext.html": {"lowerIsBetter": false, "filtered": 17247.040446122344, "unit": "ms", "value": 17247.040446122344}, "prototype.html": {"lowerIsBetter": false, "filtered": 4168.05785768386, "unit": "ms", "value": 4168.05785768386}, "yui.html": {"lowerIsBetter": false, "filtered": 5338.441477269306, "unit": "ms", "value": 5338.441477269306}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447332169, "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": "20151112025847", "branch": "Firefox-Non-PGO", "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 163.0, 163.0], "ai-astar": [109.0, 114.0, 106.0, 114.0, 112.0, 112.0, 101.0, 112.0, 110.0, 103.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0, 113.0, 111.0], "audio-beat-detection": [154.0, 130.0, 158.0, 174.0, 132.0, 153.0, 152.0, 130.0, 172.0, 131.0], "json-stringify-tinderbox": [67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0], "stanford-crypto-pbkdf2": [153.0, 139.0, 145.0, 144.0, 144.0, 136.0, 145.0, 163.0, 151.0, 137.0], "json-parse-financial": [72.0, 70.0, 71.0, 72.0, 72.0, 71.0, 72.0, 80.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [70.0, 68.0, 68.0, 68.0, 71.0, 70.0, 68.0, 69.0, 69.0, 68.0], "audio-fft": [73.0, 73.0, 79.0, 94.0, 73.0, 72.0, 72.0, 98.0, 94.0, 72.0], "imaging-darkroom": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "stanford-crypto-ccm": [121.0, 124.0, 125.0, 119.0, 125.0, 119.0, 130.0, 127.0, 127.0, 120.0], "audio-oscillator": [92.0, 91.0, 134.0, 91.0, 93.0, 92.0, 124.0, 91.0, 91.0, 134.0], "stanford-crypto-aes": [84.0, 82.0, 83.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 88.0], "imaging-desaturate": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1517.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.0, "unit": "ms", "value": 80.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 148.6, "unit": "ms", "value": 148.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.7, "unit": "ms", "value": 123.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.6, "unit": "ms", "value": 146.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.8, "unit": "ms", "value": 71.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.1, "unit": "ms", "value": 162.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.9, "unit": "ms", "value": 68.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.0, "unit": "ms", "value": 67.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.4, "unit": "ms", "value": 110.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.5, "unit": "ms", "value": 84.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447332169, "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": "20151112025847", "branch": "Firefox-Non-PGO", "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [185.8045336306206], "Encrypt": [279.4076557697681], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [605.1995163240629], "Richards": [170.88174982911826], "RegExp": [26076.923076923078], "Earley": [799.3605115907275], "Boyer": [11964.285714285714], "RayTrace": [1980.1980198019803]}, "summary": {"lowerIsBetter": false, "suite": 19880.107166938855, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 355.8470759999999, "unit": "score", "value": 355.8470759999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 952.6617989999997, "unit": "score", "value": 952.6617989999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 134.65146253746258, "unit": "score", "value": 134.65146253746258}, "RegExp": {"lowerIsBetter": false, "filtered": 34.934528023598794, "unit": "score", "value": 34.934528023598794}, "Richards": {"lowerIsBetter": false, "filtered": 206.5873039999999, "unit": "score", "value": 206.5873039999999}, "Earley": {"lowerIsBetter": false, "filtered": 833.7452129999997, "unit": "score", "value": 833.7452129999997}, "Boyer": {"lowerIsBetter": false, "filtered": 55.704370149253705, "unit": "score", "value": 55.704370149253705}, "RayTrace": {"lowerIsBetter": false, "filtered": 373.6944450000001, "unit": "score", "value": 373.6944450000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-039"}, "testrun": {"date": 1447332169, "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": "20151112025847", "branch": "Firefox-Non-PGO", "revision": "662a3871dc77c9fe85abbaba483c5537ce94100b"}}] 05:03:08 INFO - RETURN: dromaeo_css: 6096.47 05:03:08 INFO - RETURN: kraken: 1517.30 05:03:08 INFO - RETURN: v8_7: 19880.11 05:03:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19880.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1517.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6096.47"}}} 05:03:08 INFO - Return code: 0 05:03:08 INFO - # TBPL SUCCESS # 05:03:08 INFO - Running post-action listener: _resource_record_post_action 05:03:08 INFO - Running post-run listener: _resource_record_post_run 05:03:09 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 497610752; Read time: 0; Write time: 658748 05:03:09 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 212520960; Read time: 0; Write time: 306816 05:03:09 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 277520384; Read time: 0; Write time: 310500 05:03:09 INFO - Running post-run listener: _upload_blobber_files 05:03:09 INFO - Blob upload gear active. 05:03:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:03:09 INFO - Copying logs to upload dir... 05:03:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.635104 ========= master_lag: 6.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-12 05:03:13.832053) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:03:13.835572) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010037 build_url: 'https://queue.taskcluster.net/v1/task/yKoE63yXQxWM1pfFJKo5mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:03:13.864527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 9 secs) (at 2015-11-12 05:03:13.864816) ========= 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=6e558709db315bacd2260379000001b6-1447331845.948654-202946340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 69.67 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 9 secs) (at 2015-11-12 05:04:23.543320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 05:04:23.543643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 05:04:23.868911) ========= ========= Total master_lag: 75.86 =========