builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1447762165.4 results: success (0) buildid: 20151117030105 builduid: c1dda71e472747f5bea520f32f32e1fd revision: 898c2c656e4b156c323416ef0c859915f3fd2308 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.399516) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.403194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.403589) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004360 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.426084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.426386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.443065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.443443) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.493384) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.493684) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.494110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.494385) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 04:09:25-- 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% 225M=0s 2015-11-17 04:09:26 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.622182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.622512) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022266 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.673950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:25.674341) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 898c2c656e4b156c323416ef0c859915f3fd2308 --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 898c2c656e4b156c323416ef0c859915f3fd2308 --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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 04:09:26,130 truncating revision to first 12 chars 2015-11-17 04:09:26,130 Setting DEBUG logging. 2015-11-17 04:09:26,130 attempt 1/10 2015-11-17 04:09:26,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/898c2c656e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 04:09:26,397 unpacking tar archive at: mozilla-central-898c2c656e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:26.236396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:26.236758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:26.248723) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:26.249186) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 04:09:26.249730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-17 04:09:26.250117) ========= /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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:26 INFO - MultiFileLogger online at 20151117 04:09:26 in /builds/slave/test 04:09:26 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:09:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:26 INFO - {'append_to_log': False, 04:09:26 INFO - 'base_work_dir': '/builds/slave/test', 04:09:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:26 INFO - 'branch': 'Firefox-Non-PGO', 04:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:26 INFO - 'config_files': ('talos/linux_config.py',), 04:09:26 INFO - 'default_actions': ('clobber', 04:09:26 INFO - 'read-buildbot-config', 04:09:26 INFO - 'download-and-extract', 04:09:26 INFO - 'populate-webroot', 04:09:26 INFO - 'create-virtualenv', 04:09:26 INFO - 'install', 04:09:26 INFO - 'run-tests'), 04:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:26 INFO - 'download_minidump_stackwalk': True, 04:09:26 INFO - 'download_symbols': 'ondemand', 04:09:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:26 INFO - 'installer_path': 'installer.exe', 04:09:26 INFO - 'log_level': 'info', 04:09:26 INFO - 'log_name': 'talos', 04:09:26 INFO - 'log_to_console': True, 04:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:26 INFO - 'opt_config_files': (), 04:09:26 INFO - 'pip_index': False, 04:09:26 INFO - 'sps_profile': False, 04:09:26 INFO - 'sps_profile_interval': 0, 04:09:26 INFO - 'suite': 'dromaeojs', 04:09:26 INFO - 'system_bits': '64', 04:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:26 INFO - 'title': 'talos-linux64-ix-045', 04:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:26 INFO - 'use_talos_json': True, 04:09:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:26 INFO - 'work_dir': 'build'} 04:09:26 INFO - ##### 04:09:26 INFO - ##### Running clobber step. 04:09:26 INFO - ##### 04:09:26 INFO - Running pre-action listener: _resource_record_pre_action 04:09:26 INFO - Running main action method: clobber 04:09:26 INFO - rmtree: /builds/slave/test/build 04:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:27 INFO - Running post-action listener: _resource_record_post_action 04:09:27 INFO - ##### 04:09:27 INFO - ##### Running read-buildbot-config step. 04:09:27 INFO - ##### 04:09:27 INFO - Running pre-action listener: _resource_record_pre_action 04:09:27 INFO - Running main action method: read_buildbot_config 04:09:27 INFO - Using buildbot properties: 04:09:27 INFO - { 04:09:27 INFO - "properties": { 04:09:27 INFO - "buildnumber": 352, 04:09:27 INFO - "product": "firefox", 04:09:27 INFO - "script_repo_revision": "production", 04:09:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:09:27 INFO - "repository": "", 04:09:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:09:27 INFO - "buildid": "20151117030105", 04:09:27 INFO - "slavename": "talos-linux64-ix-045", 04:09:27 INFO - "pgo_build": "False", 04:09:27 INFO - "basedir": "/builds/slave/test", 04:09:27 INFO - "project": "", 04:09:27 INFO - "platform": "ubuntu64_hw", 04:09:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:09:27 INFO - "slavebuilddir": "test", 04:09:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:09:27 INFO - "branch": "mozilla-central", 04:09:27 INFO - "repo_path": "mozilla-central", 04:09:27 INFO - "stage_platform": "linux64", 04:09:27 INFO - "builduid": "c1dda71e472747f5bea520f32f32e1fd", 04:09:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:09:27 INFO - }, 04:09:27 INFO - "sourcestamp": { 04:09:27 INFO - "repository": "", 04:09:27 INFO - "hasPatch": false, 04:09:27 INFO - "project": "", 04:09:27 INFO - "branch": "mozilla-central-linux64-talos", 04:09:27 INFO - "changes": [ 04:09:27 INFO - { 04:09:27 INFO - "category": null, 04:09:27 INFO - "files": [ 04:09:27 INFO - { 04:09:27 INFO - "url": null, 04:09:27 INFO - "name": "https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:09:27 INFO - } 04:09:27 INFO - ], 04:09:27 INFO - "repository": "", 04:09:27 INFO - "rev": "898c2c656e4b156c323416ef0c859915f3fd2308", 04:09:27 INFO - "who": "cbook@mozilla.com", 04:09:27 INFO - "when": 1447762148, 04:09:27 INFO - "number": 6671414, 04:09:27 INFO - "comments": "merge b2g-inbound to mozilla-central a=merge", 04:09:27 INFO - "project": "", 04:09:27 INFO - "at": "Tue 17 Nov 2015 04:09:08", 04:09:27 INFO - "branch": "mozilla-central-linux64-talos", 04:09:27 INFO - "revlink": "", 04:09:27 INFO - "properties": [ 04:09:27 INFO - [ 04:09:27 INFO - "buildid", 04:09:27 INFO - "20151117030105", 04:09:27 INFO - "Change" 04:09:27 INFO - ], 04:09:27 INFO - [ 04:09:27 INFO - "builduid", 04:09:27 INFO - "c1dda71e472747f5bea520f32f32e1fd", 04:09:27 INFO - "Change" 04:09:27 INFO - ], 04:09:27 INFO - [ 04:09:27 INFO - "pgo_build", 04:09:27 INFO - "False", 04:09:27 INFO - "Change" 04:09:27 INFO - ] 04:09:27 INFO - ], 04:09:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:09:27 INFO - } 04:09:27 INFO - ], 04:09:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:09:27 INFO - } 04:09:27 INFO - } 04:09:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:09:27 INFO - Running post-action listener: _resource_record_post_action 04:09:27 INFO - ##### 04:09:27 INFO - ##### Running download-and-extract step. 04:09:27 INFO - ##### 04:09:27 INFO - Running pre-action listener: _resource_record_pre_action 04:09:27 INFO - Running main action method: download_and_extract 04:09:27 INFO - mkdir: /builds/slave/test/build/tests 04:09: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:09:27 INFO - https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/test_packages.json 04:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/test_packages.json 04:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:09:30 INFO - Downloaded 1302 bytes. 04:09:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:09:30 INFO - Using the following test package requirements: 04:09:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'jsshell-linux-x86_64.zip'], 04:09:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09: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:09:30 INFO - https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:31 INFO - Downloaded 21278087 bytes. 04:09:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:09:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:09:32 INFO - Return code: 0 04:09:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:32 INFO - https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:36 INFO - Downloaded 21278087 bytes. 04:09:36 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:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:09:36 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:09:37 INFO - Return code: 0 04:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:37 INFO - https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:38 INFO - Downloaded 11131693 bytes. 04:09:38 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:09:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:38 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:09:38 INFO - Return code: 0 04:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:38 INFO - https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQmT1j56TOuju97AqWiWPA/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:09:39 INFO - Downloaded 55624824 bytes. 04:09:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:39 INFO - mkdir: /builds/slave/test/properties 04:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:39 INFO - Contents: 04:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - Running post-action listener: set_extra_try_arguments 04:09:39 INFO - ##### 04:09:39 INFO - ##### Running populate-webroot step. 04:09:39 INFO - ##### 04:09:39 INFO - Running pre-action listener: _resource_record_pre_action 04:09:39 INFO - Running main action method: populate_webroot 04:09:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:09:39 INFO - '../fennec_ids.txt'], 04:09:39 INFO - 'tests': ['tcheck2']}, 04:09:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:39 INFO - '--tppagecycles', 04:09:39 INFO - '7'], 04:09:39 INFO - 'tests': ['tsvgm']}}, 04:09:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'tests': ['damp', 'tps']}, 04:09:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['damp', 'tps']}, 04:09:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:39 INFO - 'other': {'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'other_l64': {'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:39 INFO - 'ts_paint', 04:09:39 INFO - 'tpaint', 04:09:39 INFO - 'sessionrestore', 04:09:39 INFO - 'sessionrestore_no_auto_restore']}, 04:09:39 INFO - 'svgr': {'tests': ['tsvgx', 04:09:39 INFO - 'tsvgr_opacity', 04:09:39 INFO - 'tart', 04:09:39 INFO - 'tscrollx', 04:09:39 INFO - 'cart']}, 04:09:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['tsvgx', 04:09:39 INFO - 'tsvgr_opacity', 04:09:39 INFO - 'tart', 04:09:39 INFO - 'tscrollx', 04:09:39 INFO - 'cart']}, 04:09:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'tests': ['tp5o']}, 04:09:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'talos_options': ['--e10s'], 04:09:39 INFO - 'tests': ['tp5o']}, 04:09:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'talos_options': ['--xperf_path', 04:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:39 INFO - 'tests': ['tp5n']}, 04:09:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:39 INFO - 'talos_options': ['--e10s', 04:09:39 INFO - '--xperf_path', 04:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:39 INFO - 'tests': ['tp5n']}}, 04:09:39 INFO - 'talos.zip': {'path': '', 04:09:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - ##### 04:09:39 INFO - ##### Running create-virtualenv step. 04:09:39 INFO - ##### 04:09:39 INFO - Running pre-action listener: _resource_record_pre_action 04:09:39 INFO - Running main action method: create_virtualenv 04:09:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:39 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:09:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:39 INFO - Using real prefix '/usr' 04:09:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:42 INFO - Installing pip.................done. 04:09:42 INFO - Return code: 0 04:09:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 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:09:42 INFO - Cleaning up... 04:09:42 INFO - Return code: 0 04:09:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 INFO - Downloading/unpacking psutil>=0.7.1 04:09:42 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:09:42 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:09:42 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:09:42 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:09:42 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:09:42 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:09:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:44 INFO - Installing collected packages: psutil 04:09:44 INFO - Running setup.py install for psutil 04:09:44 INFO - building 'psutil._psutil_linux' extension 04:09:44 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:09:44 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:09:44 INFO - building 'psutil._psutil_posix' extension 04:09:44 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:09:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:45 INFO - Successfully installed psutil 04:09:45 INFO - Cleaning up... 04:09:45 INFO - Return code: 0 04:09:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:09:45 INFO - Using env: {'DISPLAY': ':0', 04:09:45 INFO - 'HOME': '/home/cltbld', 04:09:45 INFO - 'LANG': 'en_US.UTF-8', 04:09:45 INFO - 'LANGUAGE': 'en_US:en', 04:09:45 INFO - 'LOGNAME': 'cltbld', 04:09:45 INFO - 'MAIL': '/var/mail/cltbld', 04:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:45 INFO - 'MOZ_NO_REMOTE': '1', 04:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:45 INFO - 'NO_EM_RESTART': '1', 04:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:45 INFO - 'PWD': '/builds/slave/test', 04:09:45 INFO - 'SHELL': '/bin/bash', 04:09:45 INFO - 'SHLVL': '1', 04:09:45 INFO - 'TERM': 'linux', 04:09:45 INFO - 'TMOUT': '86400', 04:09:45 INFO - 'USER': 'cltbld', 04:09:45 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:45 INFO - '_': '/tools/buildbot/bin/python'} 04:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:47 INFO - Installing collected packages: mozsystemmonitor 04:09:47 INFO - Running setup.py install for mozsystemmonitor 04:09:47 INFO - Successfully installed mozsystemmonitor 04:09:47 INFO - Cleaning up... 04:09:47 INFO - Return code: 0 04:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:09:47 INFO - Using env: {'DISPLAY': ':0', 04:09:47 INFO - 'HOME': '/home/cltbld', 04:09:47 INFO - 'LANG': 'en_US.UTF-8', 04:09:47 INFO - 'LANGUAGE': 'en_US:en', 04:09:47 INFO - 'LOGNAME': 'cltbld', 04:09:47 INFO - 'MAIL': '/var/mail/cltbld', 04:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:47 INFO - 'MOZ_NO_REMOTE': '1', 04:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:47 INFO - 'NO_EM_RESTART': '1', 04:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:47 INFO - 'PWD': '/builds/slave/test', 04:09:47 INFO - 'SHELL': '/bin/bash', 04:09:47 INFO - 'SHLVL': '1', 04:09:47 INFO - 'TERM': 'linux', 04:09:47 INFO - 'TMOUT': '86400', 04:09:47 INFO - 'USER': 'cltbld', 04:09:47 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:47 INFO - '_': '/tools/buildbot/bin/python'} 04:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:49 INFO - Downloading docopt-0.6.1.tar.gz 04:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:49 INFO - Running setup.py install for blobuploader 04:09:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:49 INFO - Running setup.py install for requests 04:09:50 INFO - Running setup.py install for docopt 04:09:50 INFO - Successfully installed blobuploader requests docopt 04:09:50 INFO - Cleaning up... 04:09:50 INFO - Return code: 0 04:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:50 INFO - Using env: {'DISPLAY': ':0', 04:09:50 INFO - 'HOME': '/home/cltbld', 04:09:50 INFO - 'LANG': 'en_US.UTF-8', 04:09:50 INFO - 'LANGUAGE': 'en_US:en', 04:09:50 INFO - 'LOGNAME': 'cltbld', 04:09:50 INFO - 'MAIL': '/var/mail/cltbld', 04:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:50 INFO - 'MOZ_NO_REMOTE': '1', 04:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:50 INFO - 'NO_EM_RESTART': '1', 04:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:50 INFO - 'PWD': '/builds/slave/test', 04:09:50 INFO - 'SHELL': '/bin/bash', 04:09:50 INFO - 'SHLVL': '1', 04:09:50 INFO - 'TERM': 'linux', 04:09:50 INFO - 'TMOUT': '86400', 04:09:50 INFO - 'USER': 'cltbld', 04:09:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:50 INFO - '_': '/tools/buildbot/bin/python'} 04:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:50 INFO - Running setup.py (path:/tmp/pip-jBb0fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:50 INFO - Running setup.py (path:/tmp/pip-4fyBYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:50 INFO - Running setup.py (path:/tmp/pip-iqK3kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:50 INFO - Running setup.py (path:/tmp/pip-JmTtNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:50 INFO - Running setup.py (path:/tmp/pip-vQLyUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:51 INFO - Running setup.py (path:/tmp/pip-cXA8e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:51 INFO - Running setup.py (path:/tmp/pip-9Qogs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:51 INFO - Running setup.py (path:/tmp/pip-nHSeai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:51 INFO - Running setup.py (path:/tmp/pip-GREyJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:51 INFO - Running setup.py (path:/tmp/pip-z40s8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:51 INFO - Running setup.py (path:/tmp/pip-h48uZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:51 INFO - Running setup.py (path:/tmp/pip-eqsKOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:51 INFO - Running setup.py (path:/tmp/pip-P4YjCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:51 INFO - Running setup.py (path:/tmp/pip-sfRFzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:51 INFO - Running setup.py (path:/tmp/pip-yV3FmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:51 INFO - Running setup.py (path:/tmp/pip-opOXS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:51 INFO - Running setup.py (path:/tmp/pip-aIZg8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:51 INFO - Running setup.py install for manifestparser 04:09:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozcrash 04:09:52 INFO - Running setup.py install for mozdebug 04:09:52 INFO - Running setup.py install for mozdevice 04:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozfile 04:09:52 INFO - Running setup.py install for mozhttpd 04:09:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozinfo 04:09:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozInstall 04:09:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for mozleak 04:09:52 INFO - Running setup.py install for mozlog 04:09:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:52 INFO - Running setup.py install for moznetwork 04:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Running setup.py install for mozprocess 04:09:53 INFO - Running setup.py install for mozprofile 04:09:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Running setup.py install for mozrunner 04:09:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Running setup.py install for mozscreenshot 04:09:53 INFO - Running setup.py install for moztest 04:09:53 INFO - Running setup.py install for mozversion 04:09:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:53 INFO - Cleaning up... 04:09:53 INFO - Return code: 0 04:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:53 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:09:53 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:09:53 INFO - Using env: {'DISPLAY': ':0', 04:09:53 INFO - 'HOME': '/home/cltbld', 04:09:53 INFO - 'LANG': 'en_US.UTF-8', 04:09:53 INFO - 'LANGUAGE': 'en_US:en', 04:09:53 INFO - 'LOGNAME': 'cltbld', 04:09:53 INFO - 'MAIL': '/var/mail/cltbld', 04:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:53 INFO - 'MOZ_NO_REMOTE': '1', 04:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:53 INFO - 'NO_EM_RESTART': '1', 04:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:53 INFO - 'PWD': '/builds/slave/test', 04:09:53 INFO - 'SHELL': '/bin/bash', 04:09:53 INFO - 'SHLVL': '1', 04:09:53 INFO - 'TERM': 'linux', 04:09:53 INFO - 'TMOUT': '86400', 04:09:53 INFO - 'USER': 'cltbld', 04:09:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:53 INFO - '_': '/tools/buildbot/bin/python'} 04:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:53 INFO - Running setup.py (path:/tmp/pip-ZG_vit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:53 INFO - Running setup.py (path:/tmp/pip-hJ2o9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:54 INFO - Running setup.py (path:/tmp/pip-zhHLr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:54 INFO - Running setup.py (path:/tmp/pip-GPno_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:54 INFO - Running setup.py (path:/tmp/pip-0T0ii2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:54 INFO - Running setup.py (path:/tmp/pip-kBBf_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:54 INFO - Running setup.py (path:/tmp/pip-2LTQFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:54 INFO - Running setup.py (path:/tmp/pip-tZVxrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:54 INFO - Running setup.py (path:/tmp/pip-m9rIvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:54 INFO - Running setup.py (path:/tmp/pip-E1Ikgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:54 INFO - Running setup.py (path:/tmp/pip-X7NwJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:54 INFO - Running setup.py (path:/tmp/pip-1wY3av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:54 INFO - Running setup.py (path:/tmp/pip-6VKWuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:54 INFO - Running setup.py (path:/tmp/pip-zDYWUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:54 INFO - Running setup.py (path:/tmp/pip-qx5LaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:54 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:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:54 INFO - Running setup.py (path:/tmp/pip-ZSRoS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:55 INFO - Running setup.py (path:/tmp/pip-_QVq98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:56 INFO - Downloading blessings-1.5.1.tar.gz 04:09:56 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:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:56 INFO - Installing collected packages: blessings 04:09:56 INFO - Running setup.py install for blessings 04:09:56 INFO - Successfully installed blessings 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:57 INFO - Reading from file tmpfile_stdout 04:09:57 INFO - Current package versions: 04:09:57 INFO - argparse == 1.2.1 04:09:57 INFO - blessings == 1.5.1 04:09:57 INFO - blobuploader == 1.2.4 04:09:57 INFO - docopt == 0.6.1 04:09:57 INFO - manifestparser == 1.1 04:09:57 INFO - mozInstall == 1.12 04:09:57 INFO - mozcrash == 0.16 04:09:57 INFO - mozdebug == 0.1 04:09:57 INFO - mozdevice == 0.47 04:09:57 INFO - mozfile == 1.2 04:09:57 INFO - mozhttpd == 0.7 04:09:57 INFO - mozinfo == 0.9 04:09:57 INFO - mozleak == 0.1 04:09:57 INFO - mozlog == 3.0 04:09:57 INFO - moznetwork == 0.27 04:09:57 INFO - mozprocess == 0.22 04:09:57 INFO - mozprofile == 0.27 04:09:57 INFO - mozrunner == 6.11 04:09:57 INFO - mozscreenshot == 0.1 04:09:57 INFO - mozsystemmonitor == 0.0 04:09:57 INFO - moztest == 0.7 04:09:57 INFO - mozversion == 1.4 04:09:57 INFO - psutil == 3.1.1 04:09:57 INFO - requests == 1.2.3 04:09:57 INFO - wsgiref == 0.1.2 04:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:57 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:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:57 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:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:57 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 0x7f59f2a18c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, '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': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', '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:09:57 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:09:57 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:09:57 INFO - Using env: {'DISPLAY': ':0', 04:09:57 INFO - 'HOME': '/home/cltbld', 04:09:57 INFO - 'LANG': 'en_US.UTF-8', 04:09:57 INFO - 'LANGUAGE': 'en_US:en', 04:09:57 INFO - 'LOGNAME': 'cltbld', 04:09:57 INFO - 'MAIL': '/var/mail/cltbld', 04:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:57 INFO - 'MOZ_NO_REMOTE': '1', 04:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:57 INFO - 'NO_EM_RESTART': '1', 04:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:57 INFO - 'PWD': '/builds/slave/test', 04:09:57 INFO - 'SHELL': '/bin/bash', 04:09:57 INFO - 'SHLVL': '1', 04:09:57 INFO - 'TERM': 'linux', 04:09:57 INFO - 'TMOUT': '86400', 04:09:57 INFO - 'USER': 'cltbld', 04:09:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:57 INFO - '_': '/tools/buildbot/bin/python'} 04:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 INFO - Cleaning up... 04:09:57 INFO - Return code: 0 04:09:57 INFO - Running post-action listener: _resource_record_post_action 04:09:57 INFO - Running post-action listener: _start_resource_monitoring 04:09:57 INFO - Starting resource monitoring. 04:09:57 INFO - ##### 04:09:57 INFO - ##### Running install step. 04:09:57 INFO - ##### 04:09:57 INFO - Running pre-action listener: _resource_record_pre_action 04:09:57 INFO - Running main action method: install 04:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:57 INFO - Reading from file tmpfile_stdout 04:09:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:57 INFO - Reading from file tmpfile_stdout 04:09:57 INFO - Output received: 04:09:57 INFO - Usage: mozinstall [options] installer 04:09:57 INFO - Options: 04:09:57 INFO - -h, --help show this help message and exit 04:09:57 INFO - -d DEST, --destination=DEST 04:09:57 INFO - Directory to install application into. [default: 04:09:57 INFO - "/builds/slave/test"] 04:09:57 INFO - --app=APP Application being installed. [default: firefox] 04:09:57 INFO - mkdir: /builds/slave/test/build/application 04:09:57 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:09:57 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:10:11 INFO - Reading from file tmpfile_stdout 04:10:12 INFO - Output received: 04:10:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:12 INFO - Running post-action listener: _resource_record_post_action 04:10:12 INFO - ##### 04:10:12 INFO - ##### Running run-tests step. 04:10:12 INFO - ##### 04:10:12 INFO - Running pre-action listener: _resource_record_pre_action 04:10:12 INFO - Running main action method: run_tests 04:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:12 INFO - Python 2.7.3 04:10:12 INFO - Return code: 0 04:10:12 INFO - grabbing minidump binary from tooltool 04:10:12 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:10:12 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 0xd9bac0>, '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 0xd9c9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd9ce50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:12 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:10:12 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:10:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:12 INFO - Return code: 0 04:10:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:12 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/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 04:10:12 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/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 04:10:12 INFO - Using env: {'DISPLAY': ':0', 04:10:12 INFO - 'HOME': '/home/cltbld', 04:10:12 INFO - 'LANG': 'en_US.UTF-8', 04:10:12 INFO - 'LANGUAGE': 'en_US:en', 04:10:12 INFO - 'LOGNAME': 'cltbld', 04:10:12 INFO - 'MAIL': '/var/mail/cltbld', 04:10:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:12 INFO - 'MOZ_NO_REMOTE': '1', 04:10:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:12 INFO - 'NO_EM_RESTART': '1', 04:10:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:12 INFO - 'PWD': '/builds/slave/test', 04:10:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:12 INFO - 'SHELL': '/bin/bash', 04:10:12 INFO - 'SHLVL': '1', 04:10:12 INFO - 'TERM': 'linux', 04:10:12 INFO - 'TMOUT': '86400', 04:10:12 INFO - 'USER': 'cltbld', 04:10:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266', 04:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:12 INFO - '_': '/tools/buildbot/bin/python'} 04:10:12 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/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 04:10:12 INFO - mozversion INFO | application_buildid: 20151117030105 04:10:12 INFO - mozversion INFO | application_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 04:10:12 INFO - mozversion INFO | application_display_name: Nightly 04:10:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:12 INFO - mozversion INFO | application_name: Firefox 04:10:12 INFO - mozversion INFO | application_remotingname: firefox 04:10:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:10:12 INFO - mozversion INFO | application_vendor: Mozilla 04:10:12 INFO - mozversion INFO | application_version: 45.0a1 04:10:12 INFO - mozversion INFO | platform_buildid: 20151117030105 04:10:12 INFO - mozversion INFO | platform_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 04:10:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:10:12 INFO - mozversion INFO | platform_version: 45.0a1 04:10:12 INFO - 2015-11-17 04:10:12,840 DEBUG : using testdate: 1447762212 04:10:12 INFO - 2015-11-17 04:10:12,840 DEBUG : actual date: 1447762212 04:10:12 INFO - 2015-11-17 04:10:12,853 INFO : starting webserver on 'localhost:48891' 04:10:12 INFO - 2015-11-17 04:10:12,854 INFO : Starting test suite talos-linux64-ix-045 04:10:12 INFO - 2015-11-17 04:10:12,854 INFO : Starting test dromaeo_css 04:10:12 INFO - 2015-11-17 04:10:12,854 DEBUG : operating with platform_type : linux_ 04:10:12 INFO - 2015-11-17 04:10:12,855 INFO : Initialising browser for dromaeo_css test... 04:10:12 INFO - 2015-11-17 04:10:12,870 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZoEIDZ/profile http://localhost:48891/getInfo.html 04:10:16 INFO - 2015-11-17 04:10:16,947 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:16 INFO - 2015-11-17 04:10:16,947 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:16 INFO - 2015-11-17 04:10:16,947 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:16 INFO - 2015-11-17 04:10:16,947 DEBUG : BROWSER_OUTPUT: __metrics 04:10:17 INFO - 2015-11-17 04:10:17,084 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:10:18 INFO - 2015-11-17 04:10:18,289 INFO : Browser initialized. 04:10:18 INFO - 2015-11-17 04:10:18,290 INFO : Running cycle 1/1 for dromaeo_css test... 04:10:18 INFO - 2015-11-17 04:10:18,290 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZoEIDZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:30 INFO - 2015-11-17 04:10:30,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 04:10:30 INFO - 2015-11-17 04:10:30,209 DEBUG : BROWSER_OUTPUT: 04:11:21 INFO - 2015-11-17 04:11:21,432 DEBUG : BROWSER_OUTPUT: 1447762281428 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:13:33 INFO - 2015-11-17 04:13:33,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48891/tests/dromaeo/cssquery-ext.html) 04:13:34 INFO - 2015-11-17 04:13:34,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 226721792 04:13:34 INFO - 2015-11-17 04:13:34,463 DEBUG : BROWSER_OUTPUT: 04:16:36 INFO - 2015-11-17 04:16:36,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-ext.html (next: http://localhost:48891/tests/dromaeo/cssquery-jquery.html) 04:16:37 INFO - 2015-11-17 04:16:37,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 210751488 04:16:37 INFO - 2015-11-17 04:16:37,497 DEBUG : BROWSER_OUTPUT: 04:19:39 INFO - 2015-11-17 04:19:39,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48891/tests/dromaeo/cssquery-mootools.html) 04:19:40 INFO - 2015-11-17 04:19:40,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 210546688 04:19:40 INFO - 2015-11-17 04:19:40,121 DEBUG : BROWSER_OUTPUT: 04:22:41 INFO - 2015-11-17 04:22:41,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48891/tests/dromaeo/cssquery-prototype.html) 04:22:42 INFO - 2015-11-17 04:22:42,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 201785344 04:22:42 INFO - 2015-11-17 04:22:42,563 DEBUG : BROWSER_OUTPUT: 04:25:45 INFO - 2015-11-17 04:25:45,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48891/tests/dromaeo/cssquery-yui.html) 04:25:45 INFO - 2015-11-17 04:25:45,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 204685312 04:25:45 INFO - 2015-11-17 04:25:45,844 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/dromaeo/cssquery-yui.html (next: http://localhost:48891/tests/dromaeo/cssquery-dojo.html) 04:28:48 INFO - 2015-11-17 04:28:48,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 245444608 04:28:48 INFO - 2015-11-17 04:28:48,578 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,579 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:48 INFO - 2015-11-17 04:28:48,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:48 INFO - 2015-11-17 04:28:48,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:48 INFO - 2015-11-17 04:28:48,580 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:48 INFO - 2015-11-17 04:28:48,583 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2627.316897606622;2718.524258254806;2735.37086470112;2743.58846173074;2746.2722378569683;4535.886602834931;4653.813847446098;4749.121412538683;4769.070031343889;4778.378810754602;4653.464851542074;4692.765361731908;4770.260609605508;4790.377250957379;4802.327674125625;4373.628241599468;4383.12337532494;4400.8679739607705;4501.279795232764;4521.118381915511;4481.3726078349055;4485.2599321111975;4491.236489796743;4509.481409637884;4534.909301813962;4235.2800023996;4240.809163587646;4352.630026447724;4389.582989616013;4428.778561071934;4379.75911324877;4388.319810429389;4393.07745373472;4405.052913623586;4440.378347031418;4335.7181783184;4361.367601697736;4376.887557718707;4383.75889326087;4403.405540252057;4529.2526733089;4533.0480599074235;4652.837150699709;4664.32367306742;4685.1332503486965;5060.063888180662;5080.314157588715;5097.872553186163;5100.413452452978;5100.821471248526;5115.795368185268;5119.897602047976;5121.436641969381;5125.3080834087295;5160.329157209539;4512.774361281923;4604.88487787808;4631.258998560282;4632.698874573142;4727.739974301412;5221.791128354899;5232.110541208004;5258.474152584711;5271.683698978073;5308;5036.874078148076;5037.219231019198;5043.773030213649;5049.444561098277;5082.313887625197;4867.488913664085;4991.276264941564;5139.922901156486;5147.382314122329;5152.510511501401;4929.630277729185;4994;5018.372703412074;5027.597792176617;5055.646104772631;5040.319556859777;5051.419086804991;5057.8229761958155;5062.190049592121;5105.566026887682;4060.4924384451942;4165.58344165581;4201.7268877522865;4210.157968406331;4243.554426785143;3574.428091505347;3620.873269435557;3626.637336266352;3657.7073834093208;3672.026912868092;4431.047324825178;4436.268015777425;4438.622717069085;4442.800073996613;4474.552544745565;4894.094592500399;5149.536541711264;5154.30416893722;5157.097507936096;5160.380754309432;4285.228658841438;4325.6106950374615;4345.065810850682;4387.714798538085;4402.185595664812;4481.843135490242;4519.435070616173;4523.095380923828;4530.433695788027;4565.109803588269;4878.487758785347;4883.584895283941;4887.34020907173;4890.804367825247;4922.50774922512;4847.224444088929;4952.727599982036;4959.3552838132255;5076.441591425014;5202.3497062867145;4890.55984961341;4891.853244402673;4895.4859739728245;4899.510048995072;4936.481669424658;5042;5059.367579052619;5060;5060.595152387874;5098.566621837185;4926.088673595396;5021.096202683552;5048.495150484922;5110.514501122388;5136.640435169502;4791.592714619157;4885.609151267961;4893.608511319015;4894.363732714724;4933.753312334297;4973.776180071978;5019.623528235324;5023.34696489454;5024.598032157345;5069;4629.305604159403;4715.2455607104075;4739.549742774431;4898.7550622468025;4941.43173535048;4910.361652985089;4981.775820088033;5003.899922001467;5005.874853128701;5016.097102521435;4870.975645121752;4874.561289483963;4895.290182923527;4898.926516102332;4933.161362568444 04:28:48 INFO - 2015-11-17 04:28:48,583 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.3837317324117;570.785955266775;584.9795257166;586.7037146241146;595.487880422836;27786.027489037886;28310.292242693944;28350.716492835065;28380.432391352162;34068;35948.82025589875;36004.639953600454;36038;36107.81946090273;37117.44323835138;7574.128975167871;7897.605119744018;7904.170062143478;7905.446618736691;7907.4069444791585;7266.091738532684;7446.627668616547;7848.9607551962445;9865.802683946316;10113.190944724405;10003.799924001516;10046.598136074548;10071.798564028715;10089.041541053588;10109;7280.599567023812;10012.94993525035;10103.040211179927;10111.89888101117;10121.949390253001;7126.287371262884;10038.849417258747;10289.3311934724;10292.33099848515;10303.79392412155;37104.25791484155;37518.43722344167;37697.246055078744;37722.622773772186;37757.62242377596;2815.6198913146873;2902.5501047337484;2942.0438357533885;3026.803257788237;3508.8421021054114;28374;28500.429991400262;28763;29140.125796226148;29408.41183176346;2994.550817377389;3036.7722420818527;3041.2700951771635;3046.6191726034244;3134.8432578371217;239427;240379;240570;240603;240944;49813.50186498161;50717.746411267704;50734;50734.746326268134;50754.74622626863;57413.84223867727;58378;58444;58464.4153558459;58518;11615.6515304541;11659.358735269472;11690.824637630443;11729.589464368706;11731.589394371156;10318.17454603645;10359.844602330972;10384.896151038543;10418.895811041944;10436.73908152287;17400.91299543494;17459.825401746075;17538.912305438393;17938.5515362117;18161;7431.8142046449275;7683.769486915401;7711.8792332108;7716.498427602301;7740.3420709240345;798.3932211519287;814.5642081486495;829.2288172000098;882.5895958379256;919.3564504846634;26679.599806002927;26713.19860404191;26750.866245668647;26861.179576144616;26874.193774186806;891.8795962545103;912.9224015958717;935.9719208423758;937.9963439120212;1049.0925349572565;11692.240004399857;11747.060235181165;11749.412529373498;11763.117766167401;11811.881881181078;273355;274817;275976;277552;278601;44948.3257751134;45078;45116.77441612771;45139;45224.321635175496;1092.6940456672144;1099.4777480696764;1109.7281166114353;1110.2672236323988;1171.2094336323119;22972.4256893579;23409.41476463034;23444.64833027472;23677.881610592525;25594.232173034838;35188.29623407466;35278.47082293716;35340.11649708778;35355.46966795551;35484.29031419409;181072;181074;183144;184081;184193;24569.63145552854;25053.248402547953;27162.32094197661;27748.44503109967;27936.30159246035;34329.828350858086;34416.139596510286;34664.13339666528;34903.82548087243;34962.20302375753;27609.598914610393;27761.58357624597;28036.43927121487;29703.702962970958;29730;32711;32877.34245315128;33335;33499.665003349655;33514.664853351154;27639.30901727473;28119.156425307272;35847.46228806622;36069.45895811512;36447.45328820123;33685.66314336923;36722.26555468929;36932;36949.261014780095;36965.63034369622;26385.868070659522;27024.59463108094;27468.56642919635;28052.85973570119;29145 04:28:48 INFO - 2015-11-17 04:28:48,583 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.23869854301864;327.6183246517807;328.29252959871485;340.73252496790025;342.33928517960334;8939.329550283739;9232.67685631003;10454.738631534206;15182.089074655529;15772.053676779402;8869.29045676346;9934.304598678096;9995.70012899614;10190.64332748354;10221.080102790747;3967.464392307045;4047.251258517169;4047.3524236122225;4048.068944142849;4049.6557792587664;3122.235052412162;3186.6654001329875;4049.230646177232;4077.143799802045;4557.680962332638;4596.402467679197;4596.724196548218;4618.884527886813;4630.21286381316;4637.930431043537;4476.55234476553;4564.657650676179;4601.378813860137;4603.585677289043;4610.97694511527;3967.3850553164307;3968.940465893014;3970.305196590585;3971.126352202511;3974.602539746031;11307.378094204816;11526.538938442452;11601.12991525639;11608.477618507102;11610.36143012134;1680.1095419427722;1682.6298214392814;1695.127009590062;1756.1131628527512;1771.769669942912;5960.165576819249;5965.3736357682255;5978.342382337939;8034.317083047948;8735.43219690718;1595.5851478615527;1600.2478834947672;1648.4312912045325;1648.5098860939233;1693.491952414283;53344.73327633337;53663.731681341735;53830;54113.45886541124;54997.725011375085;6203.906941395792;6285.151504546919;6286;6327.335629758901;6328.430441260309;7230.2046774854725;7242.6378681065735;7243.203247642755;7245.529040612343;7257.637118144072;4734.857954261378;4769.022350418156;4802.159622066124;4804;4809.062232864628;4777.522247775195;4795.112904112751;4851.854444366674;4859.902801943941;4865.6107511399005;2786.2059313096074;2806.4948309304114;2813.057625695374;2826.759725423321;2830.2216890355317;1012.4633944009687;1021.2595867995643;1033.9741506462249;1041.8385150301715;1066.8879767624444;360.78352988206865;365.5029160341933;370.6830659785898;381.3231514062561;383.836869330539;9614.567344469377;9831.705048848546;10040.748981275381;10084.596616135272;10121.797564048826;365.5284682759264;392.0903503871049;397.0332240993133;400.07981642223353;414.9149424367997;5172.250023746536;5349.144136938149;5364.275822763955;5630.352509461382;5699.031164702011;511441;519574;523474;526975;531680;65966.34033659603;67892.660536697;68800.6559967197;68838.65580672165;69173.65413172902;440.40105456579664;448.58505882058967;449.24751042005164;449.79983907161;450.2053874910785;9054.366194366332;9180.127887850644;9188.816223675356;9269.67556135532;9393.906060939576;31461.213469663442;32353.514697280032;33202.33595328128;33291.16772080717;33431.997040088834;39409.80295098506;43609;43790.56209437865;44594.108117838114;45347.54652453565;5671.971640141773;5774.855628609318;5775.306963164448;5781.82654520365;5797.768089276382;9872.950635246778;10189.694309170736;10196.490175491344;10332.638357657446;10338.276320657482;9085.273178145864;9152.405093668891;9169.083091691044;9403.43579385239;9432.528373581155;9127.315451341043;9304.30217733659;9358.4384936904;9379.155875971195;9391.43651380892;7095.893561596684;9537.570809313736;9679.9032009679;9766.9023309766;9772.9022709772;5874.353821079763;5885.852853678693;5907.822765317047;5978.491828194652;5987.13186587951;9079.54602269897;9256.25949923991;9331.860022099538;9332.20676242527;9341.11259430353 04:28:48 INFO - 2015-11-17 04:28:48,585 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.8807551358134;1596.1460618569065;1666.3334666133549;1668.7079761041823;1695.2540882011913;5834.562407819415;6648.16897887764;7126.893096603555;7140.892886606705;7146.821329466759;7004.1595008598915;7084.822879428017;7093.751718689847;7101.183363913152;7113.5376200546925;1715.5882588178872;1746.4236801855357;1961.1567026178736;2021.3329601231594;2041.3263623004448;2040.5510787626772;2042.2443695832562;2044.253847345723;2044.509317763741;2045.9181632734746;1988.4332965104948;2008.0562135796151;2031.9695204571942;2032.5121970726993;2036.4501584572156;1965.1942703491643;1971.6155349706812;1991.1537596521493;1993.7607487101495;2015.828654564349;1887.3111314370294;1901.106479954433;1901.9714704279447;1905.3521802587186;1905.3712274949235;7059.89410158848;7169.928300716978;7170.569765814015;7172.175199852031;7173.784786456415;4050.311447054008;4128.236276288896;4128.60778226068;4150.481189851269;4153.210889930903;2289.6679981402604;2625.2780485366484;2761.061239178689;2765.405437830876;2777.916662500128;756.7880993321824;820.4420993724265;823.4236034775681;833.5332213960202;844.4890841041205;9521.381110227812;9682.854757178648;9692.079252471074;9703.417794932328;9754.26842986786;3792.6776224020714;3807.2956503047026;3832.156925476391;3852.3836186210074;3968.1071758854027;8274.089850116483;8310.70912518059;8310.83378332442;8329.125441828643;8345.582720863933;4176.102138040336;4194.517630472474;4197.811098500575;4205.642520385741;4206.305959516707;3790.677792387623;3796.2217745362136;3815.1797363566966;3816.713746469026;3817.6945844332386;3500.7724497907557;3503.3518799022263;3506.579210494757;3517.8944631661093;3545.007397928584;1070.882202957674;1073.3881687438086;1075.8655168103987;1076.5478499030269;1093.9617113400993;854.2525290370926;858.9957050214709;870.2385412763832;870.4081224767092;1025.205465764024;6406.103145559626;6420.26166990802;6443;6450.161479007699;6450.838729031811;382.27940332473486;386.7719989034803;388.7609120390996;388.96693781028364;390.0852500885476;4990;5043.218301163325;5048.040872234264;5049.242613607915;5055.494450554915;8211.83576328482;8280.917190828015;8424.326053915795;8511.319094472552;8524.914750852413;8189.590520473953;8264.256216940505;8338.374621903382;8341.20758527939;8350.206730360605;6166.414190651881;6201.162843016135;6278.372162783685;6295.18162638854;6313.40022697843;6589.901151482636;6640.037194606852;6643.169603799525;6649.567778094409;6650.334966503311;7281.599512026889;7474.103107627119;7560.810979725551;7653.272939070779;7702.499337543042;7552.962235188789;7716.922830771845;7723.497972631761;7886.68453261886;8005.9599702001115;6039.969800150971;6110.26676798787;6112.847178820565;6113.174721412553;6115.174451448997;6651.368120028589;6695;6832.419244364086;6868.828279293058;6884.827879303058;6214.9067763984485;6240.282367527792;6397.520185985976;6444;6447.290798012121;6211.720472578835;6224.906626400517;6328.240611126695;6337.524685648503;6355.52333574993;6425.6827350394;6453.225612926479;6455.838604034937;6504.739810407531;6513.772017979348;5992.310884248367;5998.040313549811;6012.518998480024;6019.067044608093;6023.3374328824675;5170.71561064145;5942.168096466585;5996.730147143477;5998.220231369894;6003.879922401615 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.69948755856115;278.92469033360993;283.22820314642604;288.5311369025334;289.5699885669779;5355.08963476209;5373.328333958255;5401.3248343957;5434.646747961379;5442.8911421771545;5032.748362581875;5156.845294641157;5189.299444574981;5277.762500687469;5334.119870221409;4006.579309172524;4035.4955630546183;4053.574374690659;4064.1871625674985;4075.3886916962397;3894.766314021168;4053.108316170438;4063;4064.817083231247;4066.4713587233764;3912.4326972588956;3960.881173564798;4015.2973229684835;4021.5978402159844;4048.9595104048876;4015.6586690131376;4016.3172260715746;4024.6579040781567;4025.215083058805;4031.838726450953;3489.3370259650837;3492.4237500812337;3494.8077855717925;3495.388307046282;3496.7202623790035;5090.465501122403;5092.490750924915;5093.898122037538;5094.261332106824;5100.234964755279;4516.277395616686;4563.612092972101;4626.306054091913;4633.536646335339;4634.629229661619;5570.359408668014;5576.832695019156;5579.7489112990015;5581.8604534886545;5584.86037849057;3803.4976184407283;3806.2197249563774;3806.4290356446754;3806.5622453417936;3813.923721525554;5836.5914385993;5851.180834683105;5860.238169038041;5863.237779088734;5870.7945221917025;3817.541894972621;3912.374020156761;3916.667083297895;3927.273454410943;3936.2127574485216;3974.761514309093;3982.960170398259;3983.14362412077;3984.7409918355215;3984.820683069269;4593.058423023273;4600.5629465200755;4604.907901842012;4608.101420223092;4612.0545288215835;5588.189712491666;5592.692401917852;5593.356763972195;5597.608167428241;5601.327840659147;1329.7739384304691;1395.8813500852339;1401.6565941344436;1402.5301523989579;1404.592668126232;885.84054870124;886.7650072730731;899.1008991008991;902.873597696323;903.1465265324337;4903.53416425439;4931.087748766489;4935.777889994959;4939;4943.134951383566;5754.856128596735;5755.913661295084;5756.021476348947;5758.424157584292;5764.394738552392;4783.5933945614315;4854.927176092361;4927.655064145475;4930.235813448921;4935.358403407534;3105.4254962831947;3129.4523458394688;3137.215696075981;3141.607299087614;3142.8114313140827;5555.583331250173;5567.721613919369;5573.191887176336;5573.331200255995;5573.860653483695;6004.189434426384;6006.759729610854;6008.158857759917;6011.909821352683;6024.1265016573225;5409.756560954766;5580;5588.161775733673;5592.273004509307;5598.664080155204;5795.507381872588;5846.795362162304;5858.062709966385;5860.443257890493;5865.149553314831;5705.543556515552;5719.8570035749435;5727.8568035799435;5728.6562806230095;5744.052231381942;5391.784328626811;5567.47109024642;5579.386267510652;5581.6371935824045;5583.972080139573;3920.2747491714126;3967.6032396760093;3971.900702482461;3974;3977.3636218204947;5788.739506722123;5800.187973683604;5800.883982320245;5801.912971305349;5802.883942321215;5590.217369568345;5595.216669666169;5595.888082238251;5600.915986260291;5608.523275521627;5431.375391829832;5615.831525054255;5634.380218176079;5638.88722225545;5639.689817060101;5477.096279113902;5482.205080263419;5490.313710786152;5496.285482887199;5499.587530935276;5671.914921276101;5674.233978412862;5682.460166284196;5684.033714268667;5685.147227915846;5409.702466364388;5535.391106978149;5540.695261760642;5546.750396232099;5551.444855514416 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: |5;yui.html;632.0708558419122;649.0685865782599;649.1107183159072;656.9868602627947;769.3652736492395;11420.200585958986;11746.471408786614;11771.352575608349;13302.334883255822;13704.246266455366;11803.763924721501;11875.465604047817;11897.524099036049;11910.702232444193;11919.225250358742;592.6651441935314;600.6696317025641;756.1946526948796;761.6724808332415;763.5380594740158;745.4260219630908;750.1972889008763;760.0499375780274;760.1790066727921;760.5930827007552;660.9239937407187;663.3366633366634;663.3764261594087;663.5554178700258;663.8108139180334;618.0883197284015;623.6756886419082;623.7068577768441;651.9087327774115;768.8500742355243;561.4161272276868;568.897598432282;572.1703529881646;572.7909313100688;573.6758731316793;11859.644210673694;12126.939365303117;12133.93933030338;12143.392830358534;12144.089193310538;8958.776030599221;9143.222826059726;9313.534323283877;9700.126988571063;9744.464054477;8733.7816554586;9019.549022548912;9184.081591840762;9226.90773092274;9353.971063183044;2748.244232835986;2797.7621902138344;2890.8843646254127;2940.911772646824;2977.0622253989923;39295.21409571793;39632.801835990635;39730.20539589192;39738.80130599358;39749;9267.472548305535;9311.208547273558;9363.391379560308;9585.329026968046;9590.376625519319;16429.342826286815;17015.82984170167;17030.659386812444;17034.97790132596;17068.573285667957;6105.32841387447;6456.0961465394885;6506.60960342381;6531.771388001397;6694.230163531159;3556.7510274280553;3631.6913062389995;3631.763935344194;3649.908752281161;3654.926901462009;2709.5529237675955;2734.0567504211017;2739.7260273972443;2742.287005378616;2744.0395861448333;397.7653184621087;408.75533998973197;411.54935345796304;413.9958600414017;414.349471330009;351.3254551261584;356.01739199808713;375.5812269319689;395.07355251934166;414.32051435645565;6746.22418421878;7078.823029424203;7199.964000179965;7286.198518162998;7314.707411703579;460.61538615255967;479.84884761300077;521.7860677122437;530.2046929605592;534.3187436019107;3233.7898036627544;3302.5871766029245;3309.8841540545964;3398.9490157647656;3406.9659303407143;46188.5381146191;46331;47110.29334559984;49305.26042109371;49399.50600494021;41260.587394126276;41602.95992600209;41729.165416691496;43834.12331753347;45732;41737.791311042645;42256.15487690229;42492.150156997304;42777.35833962493;43112.137757245306;6974.267701891228;7544.4341674373545;7565.962170189114;7601.3918886487845;7637.427192960439;31678;32257.354852902343;32264.35373809527;32402.027939161864;32751.508727368633;37583;39094.4135837957;41646.37530437107;42503.3624495639;42689;5957.791477298274;6098.512119030378;6110.388961104032;6186.628802271878;6396.584222025554;10375.740606484898;10386.376817390981;10447.111995480469;10560.894391055992;10850.945745271223;9718.514074296398;9932.354396964174;9960.402375857471;10169.694909152737;10225.693229203136;9887.653932112342;9899.25187032419;9956.601735930482;9995.20038396941;10016.39901605906;8134.715284965235;8330.541820199947;8602.956985215034;8608.354373421893;8811.735647930573;7880.763577092696;8245.422820402515;8403.663853445794;8607.48355098696;8616.267617252604;8005.759827205193;8126.593670316579;8144.267015968591;8217.5480348579;8368.24685778283 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,783 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: __startTimestamp1447763328579__endTimestamp 04:28:48 INFO - 2015-11-17 04:28:48,586 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,587 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4690.56 Median:4874.56 stddev:497.59 (10.2%) stddev-sans-first:472.06 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: Values: 2627.3 2718.5 2735.4 2743.6 2746.3 4535.9 4653.8 4749.1 4769.1 4778.4 4653.5 4692.8 4770.3 4790.4 4802.3 4373.6 4383.1 4400.9 4501.3 4521.1 4481.4 4485.3 4491.2 4509.5 4534.9 4235.3 4240.8 4352.6 4389.6 4428.8 4379.8 4388.3 4393.1 4405.1 4440.4 4335.7 4361.4 4376.9 4383.8 4403.4 4529.3 4533.0 4652.8 4664.3 4685.1 5060.1 5080.3 5097.9 5100.4 5100.8 5115.8 5119.9 5121.4 5125.3 5160.3 4512.8 4604.9 4631.3 4632.7 4727.7 5221.8 5232.1 5258.5 5271.7 5308.0 5036.9 5037.2 5043.8 5049.4 5082.3 4867.5 4991.3 5139.9 5147.4 5152.5 4929.6 4994.0 5018.4 5027.6 5055.6 5040.3 5051.4 5057.8 5062.2 5105.6 4060.5 4165.6 4201.7 4210.2 4243.6 3574.4 3620.9 3626.6 3657.7 3672.0 4431.0 4436.3 4438.6 4442.8 4474.6 4894.1 5149.5 5154.3 5157.1 5160.4 4285.2 4325.6 4345.1 4387.7 4402.2 4481.8 4519.4 4523.1 4530.4 4565.1 4878.5 4883.6 4887.3 4890.8 4922.5 4847.2 4952.7 4959.4 5076.4 5202.3 4890.6 4891.9 4895.5 4899.5 4936.5 5042.0 5059.4 5060.0 5060.6 5098.6 4926.1 5021.1 5048.5 5110.5 5136.6 4791.6 4885.6 4893.6 4894.4 4933.8 4973.8 5019.6 5023.3 5024.6 5069.0 4629.3 4715.2 4739.5 4898.8 4941.4 4910.4 4981.8 5003.9 5005.9 5016.1 4871.0 4874.6 4895.3 4898.9 4933.2 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39025.01 Median:16175.23 stddev:61565.56 (380.6%) stddev-sans-first:61670.54 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: Values: 565.4 570.8 585.0 586.7 595.5 27786.0 28310.3 28350.7 28380.4 34068.0 35948.8 36004.6 36038.0 36107.8 37117.4 7574.1 7897.6 7904.2 7905.4 7907.4 7266.1 7446.6 7849.0 9865.8 10113.2 10003.8 10046.6 10071.8 10089.0 10109.0 7280.6 10012.9 10103.0 10111.9 10121.9 7126.3 10038.8 10289.3 10292.3 10303.8 37104.3 37518.4 37697.2 37722.6 37757.6 2815.6 2902.6 2942.0 3026.8 3508.8 28374.0 28500.4 28763.0 29140.1 29408.4 2994.6 3036.8 3041.3 3046.6 3134.8 239427.0 240379.0 240570.0 240603.0 240944.0 49813.5 50717.7 50734.0 50734.7 50754.7 57413.8 58378.0 58444.0 58464.4 58518.0 11615.7 11659.4 11690.8 11729.6 11731.6 10318.2 10359.8 10384.9 10418.9 10436.7 17400.9 17459.8 17538.9 17938.6 18161.0 7431.8 7683.8 7711.9 7716.5 7740.3 798.4 814.6 829.2 882.6 919.4 26679.6 26713.2 26750.9 26861.2 26874.2 891.9 912.9 936.0 938.0 1049.1 11692.2 11747.1 11749.4 11763.1 11811.9 273355.0 274817.0 275976.0 277552.0 278601.0 44948.3 45078.0 45116.8 45139.0 45224.3 1092.7 1099.5 1109.7 1110.3 1171.2 22972.4 23409.4 23444.6 23677.9 25594.2 35188.3 35278.5 35340.1 35355.5 35484.3 181072.0 181074.0 183144.0 184081.0 184193.0 24569.6 25053.2 27162.3 27748.4 27936.3 34329.8 34416.1 34664.1 34903.8 34962.2 27609.6 27761.6 28036.4 29703.7 29730.0 32711.0 32877.3 33335.0 33499.7 33514.7 27639.3 28119.2 35847.5 36069.5 36447.5 33685.7 36722.3 36932.0 36949.3 36965.6 26385.9 27024.6 27468.6 28052.9 29145.0 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24928.51 Median:4634.07 stddev:85667.55 (1848.6%) stddev-sans-first:85887.93 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: Values: 315.2 327.6 328.3 340.7 342.3 8939.3 9232.7 10454.7 15182.1 15772.1 8869.3 9934.3 9995.7 10190.6 10221.1 3967.5 4047.3 4047.4 4048.1 4049.7 3122.2 3186.7 4049.2 4077.1 4557.7 4596.4 4596.7 4618.9 4630.2 4637.9 4476.6 4564.7 4601.4 4603.6 4611.0 3967.4 3968.9 3970.3 3971.1 3974.6 11307.4 11526.5 11601.1 11608.5 11610.4 1680.1 1682.6 1695.1 1756.1 1771.8 5960.2 5965.4 5978.3 8034.3 8735.4 1595.6 1600.2 1648.4 1648.5 1693.5 53344.7 53663.7 53830.0 54113.5 54997.7 6203.9 6285.2 6286.0 6327.3 6328.4 7230.2 7242.6 7243.2 7245.5 7257.6 4734.9 4769.0 4802.2 4804.0 4809.1 4777.5 4795.1 4851.9 4859.9 4865.6 2786.2 2806.5 2813.1 2826.8 2830.2 1012.5 1021.3 1034.0 1041.8 1066.9 360.8 365.5 370.7 381.3 383.8 9614.6 9831.7 10040.7 10084.6 10121.8 365.5 392.1 397.0 400.1 414.9 5172.3 5349.1 5364.3 5630.4 5699.0 511441.0 519574.0 523474.0 526975.0 531680.0 65966.3 67892.7 68800.7 68838.7 69173.7 440.4 448.6 449.2 449.8 450.2 9054.4 9180.1 9188.8 9269.7 9393.9 31461.2 32353.5 33202.3 33291.2 33432.0 39409.8 43609.0 43790.6 44594.1 45347.5 5672.0 5774.9 5775.3 5781.8 5797.8 9873.0 10189.7 10196.5 10332.6 10338.3 9085.3 9152.4 9169.1 9403.4 9432.5 9127.3 9304.3 9358.4 9379.2 9391.4 7095.9 9537.6 9679.9 9766.9 9772.9 5874.4 5885.9 5907.8 5978.5 5987.1 9079.5 9256.3 9331.9 9332.2 9341.1 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,588 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4887.27 Median:6114.17 stddev:2588.77 (42.3%) stddev-sans-first:2582.79 04:28:48 INFO - 2015-11-17 04:28:48,590 DEBUG : BROWSER_OUTPUT: Values: 1402.9 1596.1 1666.3 1668.7 1695.3 5834.6 6648.2 7126.9 7140.9 7146.8 7004.2 7084.8 7093.8 7101.2 7113.5 1715.6 1746.4 1961.2 2021.3 2041.3 2040.6 2042.2 2044.3 2044.5 2045.9 1988.4 2008.1 2032.0 2032.5 2036.5 1965.2 1971.6 1991.2 1993.8 2015.8 1887.3 1901.1 1902.0 1905.4 1905.4 7059.9 7169.9 7170.6 7172.2 7173.8 4050.3 4128.2 4128.6 4150.5 4153.2 2289.7 2625.3 2761.1 2765.4 2777.9 756.8 820.4 823.4 833.5 844.5 9521.4 9682.9 9692.1 9703.4 9754.3 3792.7 3807.3 3832.2 3852.4 3968.1 8274.1 8310.7 8310.8 8329.1 8345.6 4176.1 4194.5 4197.8 4205.6 4206.3 3790.7 3796.2 3815.2 3816.7 3817.7 3500.8 3503.4 3506.6 3517.9 3545.0 1070.9 1073.4 1075.9 1076.5 1094.0 854.3 859.0 870.2 870.4 1025.2 6406.1 6420.3 6443.0 6450.2 6450.8 382.3 386.8 388.8 389.0 390.1 4990.0 5043.2 5048.0 5049.2 5055.5 8211.8 8280.9 8424.3 8511.3 8524.9 8189.6 8264.3 8338.4 8341.2 8350.2 6166.4 6201.2 6278.4 6295.2 6313.4 6589.9 6640.0 6643.2 6649.6 6650.3 7281.6 7474.1 7560.8 7653.3 7702.5 7553.0 7716.9 7723.5 7886.7 8006.0 6040.0 6110.3 6112.8 6113.2 6115.2 6651.4 6695.0 6832.4 6868.8 6884.8 6214.9 6240.3 6397.5 6444.0 6447.3 6211.7 6224.9 6328.2 6337.5 6355.5 6425.7 6453.2 6455.8 6504.7 6513.8 5992.3 5998.0 6012.5 6019.1 6023.3 5170.7 5942.2 5996.7 5998.2 6003.9 04:28:48 INFO - 2015-11-17 04:28:48,590 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,590 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4620.85 Median:5364.21 stddev:1392.26 (26.0%) stddev-sans-first:1357.43 04:28:48 INFO - 2015-11-17 04:28:48,590 DEBUG : BROWSER_OUTPUT: Values: 275.7 278.9 283.2 288.5 289.6 5355.1 5373.3 5401.3 5434.6 5442.9 5032.7 5156.8 5189.3 5277.8 5334.1 4006.6 4035.5 4053.6 4064.2 4075.4 3894.8 4053.1 4063.0 4064.8 4066.5 3912.4 3960.9 4015.3 4021.6 4049.0 4015.7 4016.3 4024.7 4025.2 4031.8 3489.3 3492.4 3494.8 3495.4 3496.7 5090.5 5092.5 5093.9 5094.3 5100.2 4516.3 4563.6 4626.3 4633.5 4634.6 5570.4 5576.8 5579.7 5581.9 5584.9 3803.5 3806.2 3806.4 3806.6 3813.9 5836.6 5851.2 5860.2 5863.2 5870.8 3817.5 3912.4 3916.7 3927.3 3936.2 3974.8 3983.0 3983.1 3984.7 3984.8 4593.1 4600.6 4604.9 4608.1 4612.1 5588.2 5592.7 5593.4 5597.6 5601.3 1329.8 1395.9 1401.7 1402.5 1404.6 885.8 886.8 899.1 902.9 903.1 4903.5 4931.1 4935.8 4939.0 4943.1 5754.9 5755.9 5756.0 5758.4 5764.4 4783.6 4854.9 4927.7 4930.2 4935.4 3105.4 3129.5 3137.2 3141.6 3142.8 5555.6 5567.7 5573.2 5573.3 5573.9 6004.2 6006.8 6008.2 6011.9 6024.1 5409.8 5580.0 5588.2 5592.3 5598.7 5795.5 5846.8 5858.1 5860.4 5865.1 5705.5 5719.9 5727.9 5728.7 5744.1 5391.8 5567.5 5579.4 5581.6 5584.0 3920.3 3967.6 3971.9 3974.0 3977.4 5788.7 5800.2 5800.9 5801.9 5802.9 5590.2 5595.2 5595.9 5600.9 5608.5 5431.4 5615.8 5634.4 5638.9 5639.7 5477.1 5482.2 5490.3 5496.3 5499.6 5671.9 5674.2 5682.5 5684.0 5685.1 5409.7 5535.4 5540.7 5546.8 5551.4 04:28:48 INFO - 2015-11-17 04:28:48,591 DEBUG : BROWSER_OUTPUT: 04:28:48 INFO - 2015-11-17 04:28:48,591 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11869.58 Median:526.00 stddev:13835.06 (2630.3%) stddev-sans-first:13848.14 04:28:48 INFO - 2015-11-17 04:28:48,591 DEBUG : BROWSER_OUTPUT: Values: 632.1 649.1 649.1 657.0 769.4 11420.2 11746.5 11771.4 13302.3 13704.2 11803.8 11875.5 11897.5 11910.7 11919.2 592.7 600.7 756.2 761.7 763.5 745.4 750.2 760.0 760.2 760.6 660.9 663.3 663.4 663.6 663.8 618.1 623.7 623.7 651.9 768.9 561.4 568.9 572.2 572.8 573.7 11859.6 12126.9 12133.9 12143.4 12144.1 8958.8 9143.2 9313.5 9700.1 9744.5 8733.8 9019.5 9184.1 9226.9 9354.0 2748.2 2797.8 2890.9 2940.9 2977.1 39295.2 39632.8 39730.2 39738.8 39749.0 9267.5 9311.2 9363.4 9585.3 9590.4 16429.3 17015.8 17030.7 17035.0 17068.6 6105.3 6456.1 6506.6 6531.8 6694.2 3556.8 3631.7 3631.8 3649.9 3654.9 2709.6 2734.1 2739.7 2742.3 2744.0 397.8 408.8 411.5 414.0 414.3 351.3 356.0 375.6 395.1 414.3 6746.2 7078.8 7200.0 7286.2 7314.7 460.6 479.8 521.8 530.2 534.3 3233.8 3302.6 3309.9 3398.9 3407.0 46188.5 46331.0 47110.3 49305.3 49399.5 41260.6 41603.0 41729.2 43834.1 45732.0 41737.8 42256.2 42492.2 42777.4 43112.1 6974.3 7544.4 7566.0 7601.4 7637.4 31678.0 32257.4 32264.4 32402.0 32751.5 37583.0 39094.4 41646.4 42503.4 42689.0 5957.8 6098.5 6110.4 6186.6 6396.6 10375.7 10386.4 10447.1 10560.9 10850.9 9718.5 9932.4 9960.4 10169.7 10225.7 9887.7 9899.3 9956.6 9995.2 10016.4 8134.7 8330.5 8603.0 8608.4 8811.7 7880.8 8245.4 8403.7 8607.5 8616.3 8005.8 8126.6 8144.3 8217.5 8368.2 04:28:48 INFO - 2015-11-17 04:28:48,591 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:48 INFO - 2015-11-17 04:28:48,591 DEBUG : BROWSER_OUTPUT: 04:28:49 INFO - 2015-11-17 04:28:49,297 INFO : Browser exited with error code: 0 04:28:49 INFO - 2015-11-17 04:28:49,319 INFO : Completed test dromaeo_css (00:18:36) 04:28:49 INFO - 2015-11-17 04:28:49,319 INFO : Starting test kraken 04:28:49 INFO - 2015-11-17 04:28:49,319 DEBUG : operating with platform_type : linux_ 04:28:49 INFO - 2015-11-17 04:28:49,319 INFO : Initialising browser for kraken test... 04:28:49 INFO - 2015-11-17 04:28:49,325 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSvp98m/profile http://localhost:48891/getInfo.html 04:28:53 INFO - 2015-11-17 04:28:53,238 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:53 INFO - 2015-11-17 04:28:53,238 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:53 INFO - 2015-11-17 04:28:53,238 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:53 INFO - 2015-11-17 04:28:53,238 DEBUG : BROWSER_OUTPUT: __metrics 04:28:53 INFO - 2015-11-17 04:28:53,375 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:28:54 INFO - 2015-11-17 04:28:54,493 INFO : Browser initialized. 04:28:54 INFO - 2015-11-17 04:28:54,494 INFO : Running cycle 1/1 for kraken test... 04:28:54 INFO - 2015-11-17 04:28:54,494 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSvp98m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:06 INFO - 2015-11-17 04:29:06,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 141430784 04:29:06 INFO - 2015-11-17 04:29:06,388 DEBUG : BROWSER_OUTPUT: 04:29:08 INFO - 2015-11-17 04:29:08,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48891/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:09 INFO - 2015-11-17 04:29:09,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 180158464 04:29:09 INFO - 2015-11-17 04:29:09,572 DEBUG : BROWSER_OUTPUT: 04:29:12 INFO - 2015-11-17 04:29:12,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48891/tests/kraken/driver.html?testName=audio-dft) 04:29:12 INFO - 2015-11-17 04:29:12,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 169869312 04:29:12 INFO - 2015-11-17 04:29:12,821 DEBUG : BROWSER_OUTPUT: 04:29:15 INFO - 2015-11-17 04:29:15,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48891/tests/kraken/driver.html?testName=audio-fft) 04:29:16 INFO - 2015-11-17 04:29:16,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 151584768 04:29:16 INFO - 2015-11-17 04:29:16,405 DEBUG : BROWSER_OUTPUT: 04:29:18 INFO - 2015-11-17 04:29:18,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48891/tests/kraken/driver.html?testName=audio-oscillator) 04:29:19 INFO - 2015-11-17 04:29:19,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 155000832 04:29:19 INFO - 2015-11-17 04:29:19,015 DEBUG : BROWSER_OUTPUT: 04:29:21 INFO - 2015-11-17 04:29:21,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48891/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:21 INFO - 2015-11-17 04:29:21,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 154505216 04:29:21 INFO - 2015-11-17 04:29:21,779 DEBUG : BROWSER_OUTPUT: 04:29:24 INFO - 2015-11-17 04:29:24,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48891/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:25 INFO - 2015-11-17 04:29:25,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 157011968 04:29:25 INFO - 2015-11-17 04:29:25,334 DEBUG : BROWSER_OUTPUT: 04:29:28 INFO - 2015-11-17 04:29:28,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48891/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:29 INFO - 2015-11-17 04:29:29,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 154812416 04:29:29 INFO - 2015-11-17 04:29:29,407 DEBUG : BROWSER_OUTPUT: 04:29:32 INFO - 2015-11-17 04:29:32,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48891/tests/kraken/driver.html?testName=json-parse-financial) 04:29:32 INFO - 2015-11-17 04:29:32,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 155484160 04:29:32 INFO - 2015-11-17 04:29:32,842 DEBUG : BROWSER_OUTPUT: 04:29:34 INFO - 2015-11-17 04:29:34,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48891/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:35 INFO - 2015-11-17 04:29:35,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 167567360 04:29:35 INFO - 2015-11-17 04:29:35,147 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2015-11-17 04:29:37,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:37 INFO - 2015-11-17 04:29:37,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 165212160 04:29:37 INFO - 2015-11-17 04:29:37,627 DEBUG : BROWSER_OUTPUT: 04:29:39 INFO - 2015-11-17 04:29:39,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:40 INFO - 2015-11-17 04:29:40,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 175345664 04:29:40 INFO - 2015-11-17 04:29:40,333 DEBUG : BROWSER_OUTPUT: 04:29:42 INFO - 2015-11-17 04:29:42,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:43 INFO - 2015-11-17 04:29:43,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 180387840 04:29:43 INFO - 2015-11-17 04:29:43,442 DEBUG : BROWSER_OUTPUT: 04:29:46 INFO - 2015-11-17 04:29:46,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:46 INFO - 2015-11-17 04:29:46,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 179662848 04:29:46 INFO - 2015-11-17 04:29:46,669 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48891/tests/kraken/driver.html?testName=ai-astar) 04:29:48 INFO - 2015-11-17 04:29:48,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 237457408 04:29:48 INFO - 2015-11-17 04:29:48,703 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,706 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;105;113;112;111;101;111;115;111 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;131;155;164;131;156;151;132;175;130 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;161;161;161;161;163;164;163 04:29:48 INFO - 2015-11-17 04:29:48,707 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;95;72;73;72;101;89;73 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;130;91;92;93;128;92;93;126 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;110;110;109;110;110 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;147;148;147;147;147;147 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;95;95;95;95 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;69;69;69;68;68;78;66;68 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;68;69;75;68;69;69 04:29:48 INFO - 2015-11-17 04:29:48,708 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;84;83;85;82;84;84;83;82 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;128;117;120;128;125;124;129;128;120 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;149;148;148;153;139;150;165;138;137 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;73;73;70;72;73;71;70;70;71 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 04:29:48 INFO - 2015-11-17 04:29:48,709 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:29:48 INFO - 2015-11-17 04:29:48,710 DEBUG : BROWSER_OUTPUT: __startTimestamp1447763388704__endTimestamp 04:29:48 INFO - 2015-11-17 04:29:48,710 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,713 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:48 INFO - 2015-11-17 04:29:48,713 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:29:48 INFO - 2015-11-17 04:29:48,713 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,714 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.24 (3.8%) stddev-sans-first:4.50 04:29:48 INFO - 2015-11-17 04:29:48,714 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 105.0 113.0 112.0 111.0 101.0 111.0 115.0 111.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:155.00 stddev:16.03 (10.3%) stddev-sans-first:16.81 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: Values: 155.0 131.0 155.0 164.0 131.0 156.0 151.0 132.0 175.0 130.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 161.0 161.0 161.0 161.0 163.0 164.0 163.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:10.91 (14.9%) stddev-sans-first:11.26 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 95.0 72.0 73.0 72.0 101.0 89.0 73.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:92.00 stddev:17.36 (18.9%) stddev-sans-first:17.95 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 130.0 91.0 92.0 93.0 128.0 92.0 93.0 126.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 04:29:48 INFO - 2015-11-17 04:29:48,715 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.20 Median:69.00 stddev:3.22 (4.7%) stddev-sans-first:3.42 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 69.0 68.0 68.0 78.0 66.0 68.0 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:2.10 (3.0%) stddev-sans-first:2.22 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 69.0 75.0 68.0 69.0 69.0 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.96 (3.5%) stddev-sans-first:3.04 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 84.0 83.0 85.0 82.0 84.0 84.0 83.0 82.0 04:29:48 INFO - 2015-11-17 04:29:48,716 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:127.50 stddev:4.22 (3.3%) stddev-sans-first:4.39 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: Values: 127.0 128.0 117.0 120.0 128.0 125.0 124.0 129.0 128.0 120.0 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:149.50 stddev:9.64 (6.4%) stddev-sans-first:8.79 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: Values: 163.0 149.0 148.0 148.0 153.0 139.0 150.0 165.0 138.0 137.0 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 70.0 72.0 73.0 71.0 70.0 70.0 71.0 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:48 INFO - 2015-11-17 04:29:48,717 DEBUG : BROWSER_OUTPUT: 04:29:49 INFO - 2015-11-17 04:29:49,662 INFO : Browser exited with error code: 0 04:29:49 INFO - 2015-11-17 04:29:49,713 INFO : Completed test kraken (00:01:00) 04:29:49 INFO - 2015-11-17 04:29:49,713 INFO : Starting test v8_7 04:29:49 INFO - 2015-11-17 04:29:49,713 DEBUG : operating with platform_type : linux_ 04:29:49 INFO - 2015-11-17 04:29:49,713 INFO : Initialising browser for v8_7 test... 04:29:49 INFO - 2015-11-17 04:29:49,719 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxw88s0/profile http://localhost:48891/getInfo.html 04:29:53 INFO - 2015-11-17 04:29:53,643 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:53 INFO - 2015-11-17 04:29:53,643 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:53 INFO - 2015-11-17 04:29:53,643 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:29:53 INFO - 2015-11-17 04:29:53,643 DEBUG : BROWSER_OUTPUT: __metrics 04:29:53 INFO - 2015-11-17 04:29:53,768 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:29:54 INFO - 2015-11-17 04:29:54,938 INFO : Browser initialized. 04:29:54 INFO - 2015-11-17 04:29:54,939 INFO : Running cycle 1/1 for v8_7 test... 04:29:54 INFO - 2015-11-17 04:29:54,939 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxw88s0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:30:06 INFO - 2015-11-17 04:30:06,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 04:30:06 INFO - 2015-11-17 04:30:06,929 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48891/tests/v8_7/run.html (next: http://localhost:48891/tests/v8_7/run.html) 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 437452800 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:30:28 INFO - 2015-11-17 04:30:28,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.3816852635629 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |2;Encrypt;290.1073397156948 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 04:30:28 INFO - 2015-11-17 04:30:28,588 DEBUG : BROWSER_OUTPUT: |5;Earley;833.3333333333334 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: |6;Boyer;11882.35294117647 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: |8;Splay;597.7286312014345 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1447763428585__endTimestamp 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: Values: 165.8 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.38 Median:192.38 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: Values: 192.4 04:30:28 INFO - 2015-11-17 04:30:28,590 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:290.11 Median:290.11 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: Values: 290.1 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: Values: 5015.0 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: Values: 2000.0 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:833.33 Median:833.33 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,591 DEBUG : BROWSER_OUTPUT: Values: 833.3 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11882.35 Median:11882.35 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: Values: 11882.4 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: Values: 26921.1 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.73 Median:597.73 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: Values: 597.7 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: 04:30:28 INFO - 2015-11-17 04:30:28,592 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:30:28 INFO - 2015-11-17 04:30:28,593 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:30:28 INFO - 2015-11-17 04:30:28,593 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:30:28 INFO - 2015-11-17 04:30:28,593 DEBUG : BROWSER_OUTPUT: 04:30:29 INFO - 2015-11-17 04:30:29,521 INFO : Browser exited with error code: 0 04:30:29 INFO - 2015-11-17 04:30:29,538 INFO : Completed test v8_7 (00:00:39) 04:30:29 INFO - 2015-11-17 04:30:29,602 INFO : Completed test suite (00:20:16) 04:30:29 INFO - 2015-11-17 04:30:29,602 DEBUG : Working with test: dromaeo_css 04:30:29 INFO - 2015-11-17 04:30:29,602 DEBUG : Generating results file: dromaeo_css 04:30:29 INFO - 2015-11-17 04:30:29,603 DEBUG : Working with test: kraken 04:30:29 INFO - 2015-11-17 04:30:29,604 DEBUG : Generating results file: kraken 04:30:29 INFO - 2015-11-17 04:30:29,604 INFO : javascript benchmark 04:30:29 INFO - 2015-11-17 04:30:29,604 DEBUG : Working with test: v8_7 04:30:29 INFO - 2015-11-17 04:30:29,604 DEBUG : Generating results file: v8_7 04:30:29 INFO - 2015-11-17 04:30:29,605 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:29 INFO - 2015-11-17 04:30:29,660 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:30:29 INFO - 2015-11-17 04:30:29,660 DEBUG : process_Request line: dromaeo_css 5827.20 graph.html#tests=[[72,94,35]] 04:30:29 INFO - 2015-11-17 04:30:29,660 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:29 INFO - 2015-11-17 04:30:29,767 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,94,35]] 04:30:29 INFO - 2015-11-17 04:30:29,767 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:29 INFO - 2015-11-17 04:30:29,880 DEBUG : process_Request line: v8_7 19678.33 graph.html#tests=[[230,94,35]] 04:30:29 INFO - 2015-11-17 04:30:29,881 INFO : javascript benchmark 04:30:29 INFO - 2015-11-17 04:30:29,885 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [315.23869854301864, 327.6183246517807, 328.29252959871485, 340.73252496790025, 342.33928517960334, 8939.329550283739, 9232.67685631003, 10454.738631534206, 15182.089074655529, 15772.053676779402, 8869.29045676346, 9934.304598678096, 9995.70012899614, 10190.64332748354, 10221.080102790747, 3967.464392307045, 4047.251258517169, 4047.3524236122225, 4048.068944142849, 4049.6557792587664, 3122.235052412162, 3186.6654001329875, 4049.230646177232, 4077.143799802045, 4557.680962332638, 4596.402467679197, 4596.724196548218, 4618.884527886813, 4630.21286381316, 4637.930431043537, 4476.55234476553, 4564.657650676179, 4601.378813860137, 4603.585677289043, 4610.97694511527, 3967.3850553164307, 3968.940465893014, 3970.305196590585, 3971.126352202511, 3974.602539746031, 11307.378094204816, 11526.538938442452, 11601.12991525639, 11608.477618507102, 11610.36143012134, 1680.1095419427722, 1682.6298214392814, 1695.127009590062, 1756.1131628527512, 1771.769669942912, 5960.165576819249, 5965.3736357682255, 5978.342382337939, 8034.317083047948, 8735.43219690718, 1595.5851478615527, 1600.2478834947672, 1648.4312912045325, 1648.5098860939233, 1693.491952414283, 53344.73327633337, 53663.731681341735, 53830.0, 54113.45886541124, 54997.725011375085, 6203.906941395792, 6285.151504546919, 6286.0, 6327.335629758901, 6328.430441260309, 7230.2046774854725, 7242.6378681065735, 7243.203247642755, 7245.529040612343, 7257.637118144072, 4734.857954261378, 4769.022350418156, 4802.159622066124, 4804.0, 4809.062232864628, 4777.522247775195, 4795.112904112751, 4851.854444366674, 4859.902801943941, 4865.6107511399005, 2786.2059313096074, 2806.4948309304114, 2813.057625695374, 2826.759725423321, 2830.2216890355317, 1012.4633944009687, 1021.2595867995643, 1033.9741506462249, 1041.8385150301715, 1066.8879767624444, 360.78352988206865, 365.5029160341933, 370.6830659785898, 381.3231514062561, 383.836869330539, 9614.567344469377, 9831.705048848546, 10040.748981275381, 10084.596616135272, 10121.797564048826, 365.5284682759264, 392.0903503871049, 397.0332240993133, 400.07981642223353, 414.9149424367997, 5172.250023746536, 5349.144136938149, 5364.275822763955, 5630.352509461382, 5699.031164702011, 511441.0, 519574.0, 523474.0, 526975.0, 531680.0, 65966.34033659603, 67892.660536697, 68800.6559967197, 68838.65580672165, 69173.65413172902, 440.40105456579664, 448.58505882058967, 449.24751042005164, 449.79983907161, 450.2053874910785, 9054.366194366332, 9180.127887850644, 9188.816223675356, 9269.67556135532, 9393.906060939576, 31461.213469663442, 32353.514697280032, 33202.33595328128, 33291.16772080717, 33431.997040088834, 39409.80295098506, 43609.0, 43790.56209437865, 44594.108117838114, 45347.54652453565, 5671.971640141773, 5774.855628609318, 5775.306963164448, 5781.82654520365, 5797.768089276382, 9872.950635246778, 10189.694309170736, 10196.490175491344, 10332.638357657446, 10338.276320657482, 9085.273178145864, 9152.405093668891, 9169.083091691044, 9403.43579385239, 9432.528373581155, 9127.315451341043, 9304.30217733659, 9358.4384936904, 9379.155875971195, 9391.43651380892, 7095.893561596684, 9537.570809313736, 9679.9032009679, 9766.9023309766, 9772.9022709772, 5874.353821079763, 5885.852853678693, 5907.822765317047, 5978.491828194652, 5987.13186587951, 9079.54602269897, 9256.25949923991, 9331.860022099538, 9332.20676242527, 9341.11259430353], "dojo.html": [2627.316897606622, 2718.524258254806, 2735.37086470112, 2743.58846173074, 2746.2722378569683, 4535.886602834931, 4653.813847446098, 4749.121412538683, 4769.070031343889, 4778.378810754602, 4653.464851542074, 4692.765361731908, 4770.260609605508, 4790.377250957379, 4802.327674125625, 4373.628241599468, 4383.12337532494, 4400.8679739607705, 4501.279795232764, 4521.118381915511, 4481.3726078349055, 4485.2599321111975, 4491.236489796743, 4509.481409637884, 4534.909301813962, 4235.2800023996, 4240.809163587646, 4352.630026447724, 4389.582989616013, 4428.778561071934, 4379.75911324877, 4388.319810429389, 4393.07745373472, 4405.052913623586, 4440.378347031418, 4335.7181783184, 4361.367601697736, 4376.887557718707, 4383.75889326087, 4403.405540252057, 4529.2526733089, 4533.0480599074235, 4652.837150699709, 4664.32367306742, 4685.1332503486965, 5060.063888180662, 5080.314157588715, 5097.872553186163, 5100.413452452978, 5100.821471248526, 5115.795368185268, 5119.897602047976, 5121.436641969381, 5125.3080834087295, 5160.329157209539, 4512.774361281923, 4604.88487787808, 4631.258998560282, 4632.698874573142, 4727.739974301412, 5221.791128354899, 5232.110541208004, 5258.474152584711, 5271.683698978073, 5308.0, 5036.874078148076, 5037.219231019198, 5043.773030213649, 5049.444561098277, 5082.313887625197, 4867.488913664085, 4991.276264941564, 5139.922901156486, 5147.382314122329, 5152.510511501401, 4929.630277729185, 4994.0, 5018.372703412074, 5027.597792176617, 5055.646104772631, 5040.319556859777, 5051.419086804991, 5057.8229761958155, 5062.190049592121, 5105.566026887682, 4060.4924384451942, 4165.58344165581, 4201.7268877522865, 4210.157968406331, 4243.554426785143, 3574.428091505347, 3620.873269435557, 3626.637336266352, 3657.7073834093208, 3672.026912868092, 4431.047324825178, 4436.268015777425, 4438.622717069085, 4442.800073996613, 4474.552544745565, 4894.094592500399, 5149.536541711264, 5154.30416893722, 5157.097507936096, 5160.380754309432, 4285.228658841438, 4325.6106950374615, 4345.065810850682, 4387.714798538085, 4402.185595664812, 4481.843135490242, 4519.435070616173, 4523.095380923828, 4530.433695788027, 4565.109803588269, 4878.487758785347, 4883.584895283941, 4887.34020907173, 4890.804367825247, 4922.50774922512, 4847.224444088929, 4952.727599982036, 4959.3552838132255, 5076.441591425014, 5202.3497062867145, 4890.55984961341, 4891.853244402673, 4895.4859739728245, 4899.510048995072, 4936.481669424658, 5042.0, 5059.367579052619, 5060.0, 5060.595152387874, 5098.566621837185, 4926.088673595396, 5021.096202683552, 5048.495150484922, 5110.514501122388, 5136.640435169502, 4791.592714619157, 4885.609151267961, 4893.608511319015, 4894.363732714724, 4933.753312334297, 4973.776180071978, 5019.623528235324, 5023.34696489454, 5024.598032157345, 5069.0, 4629.305604159403, 4715.2455607104075, 4739.549742774431, 4898.7550622468025, 4941.43173535048, 4910.361652985089, 4981.775820088033, 5003.899922001467, 5005.874853128701, 5016.097102521435, 4870.975645121752, 4874.561289483963, 4895.290182923527, 4898.926516102332, 4933.161362568444], "mootools.html": [1402.8807551358134, 1596.1460618569065, 1666.3334666133549, 1668.7079761041823, 1695.2540882011913, 5834.562407819415, 6648.16897887764, 7126.893096603555, 7140.892886606705, 7146.821329466759, 7004.1595008598915, 7084.822879428017, 7093.751718689847, 7101.183363913152, 7113.5376200546925, 1715.5882588178872, 1746.4236801855357, 1961.1567026178736, 2021.3329601231594, 2041.3263623004448, 2040.5510787626772, 2042.2443695832562, 2044.253847345723, 2044.509317763741, 2045.9181632734746, 1988.4332965104948, 2008.0562135796151, 2031.9695204571942, 2032.5121970726993, 2036.4501584572156, 1965.1942703491643, 1971.6155349706812, 1991.1537596521493, 1993.7607487101495, 2015.828654564349, 1887.3111314370294, 1901.106479954433, 1901.9714704279447, 1905.3521802587186, 1905.3712274949235, 7059.89410158848, 7169.928300716978, 7170.569765814015, 7172.175199852031, 7173.784786456415, 4050.311447054008, 4128.236276288896, 4128.60778226068, 4150.481189851269, 4153.210889930903, 2289.6679981402604, 2625.2780485366484, 2761.061239178689, 2765.405437830876, 2777.916662500128, 756.7880993321824, 820.4420993724265, 823.4236034775681, 833.5332213960202, 844.4890841041205, 9521.381110227812, 9682.854757178648, 9692.079252471074, 9703.417794932328, 9754.26842986786, 3792.6776224020714, 3807.2956503047026, 3832.156925476391, 3852.3836186210074, 3968.1071758854027, 8274.089850116483, 8310.70912518059, 8310.83378332442, 8329.125441828643, 8345.582720863933, 4176.102138040336, 4194.517630472474, 4197.811098500575, 4205.642520385741, 4206.305959516707, 3790.677792387623, 3796.2217745362136, 3815.1797363566966, 3816.713746469026, 3817.6945844332386, 3500.7724497907557, 3503.3518799022263, 3506.579210494757, 3517.8944631661093, 3545.007397928584, 1070.882202957674, 1073.3881687438086, 1075.8655168103987, 1076.5478499030269, 1093.9617113400993, 854.2525290370926, 858.9957050214709, 870.2385412763832, 870.4081224767092, 1025.205465764024, 6406.103145559626, 6420.26166990802, 6443.0, 6450.161479007699, 6450.838729031811, 382.27940332473486, 386.7719989034803, 388.7609120390996, 388.96693781028364, 390.0852500885476, 4990.0, 5043.218301163325, 5048.040872234264, 5049.242613607915, 5055.494450554915, 8211.83576328482, 8280.917190828015, 8424.326053915795, 8511.319094472552, 8524.914750852413, 8189.590520473953, 8264.256216940505, 8338.374621903382, 8341.20758527939, 8350.206730360605, 6166.414190651881, 6201.162843016135, 6278.372162783685, 6295.18162638854, 6313.40022697843, 6589.901151482636, 6640.037194606852, 6643.169603799525, 6649.567778094409, 6650.334966503311, 7281.599512026889, 7474.103107627119, 7560.810979725551, 7653.272939070779, 7702.499337543042, 7552.962235188789, 7716.922830771845, 7723.497972631761, 7886.68453261886, 8005.9599702001115, 6039.969800150971, 6110.26676798787, 6112.847178820565, 6113.174721412553, 6115.174451448997, 6651.368120028589, 6695.0, 6832.419244364086, 6868.828279293058, 6884.827879303058, 6214.9067763984485, 6240.282367527792, 6397.520185985976, 6444.0, 6447.290798012121, 6211.720472578835, 6224.906626400517, 6328.240611126695, 6337.524685648503, 6355.52333574993, 6425.6827350394, 6453.225612926479, 6455.838604034937, 6504.739810407531, 6513.772017979348, 5992.310884248367, 5998.040313549811, 6012.518998480024, 6019.067044608093, 6023.3374328824675, 5170.71561064145, 5942.168096466585, 5996.730147143477, 5998.220231369894, 6003.879922401615], "ext.html": [565.3837317324117, 570.785955266775, 584.9795257166, 586.7037146241146, 595.487880422836, 27786.027489037886, 28310.292242693944, 28350.716492835065, 28380.432391352162, 34068.0, 35948.82025589875, 36004.639953600454, 36038.0, 36107.81946090273, 37117.44323835138, 7574.128975167871, 7897.605119744018, 7904.170062143478, 7905.446618736691, 7907.4069444791585, 7266.091738532684, 7446.627668616547, 7848.9607551962445, 9865.802683946316, 10113.190944724405, 10003.799924001516, 10046.598136074548, 10071.798564028715, 10089.041541053588, 10109.0, 7280.599567023812, 10012.94993525035, 10103.040211179927, 10111.89888101117, 10121.949390253001, 7126.287371262884, 10038.849417258747, 10289.3311934724, 10292.33099848515, 10303.79392412155, 37104.25791484155, 37518.43722344167, 37697.246055078744, 37722.622773772186, 37757.62242377596, 2815.6198913146873, 2902.5501047337484, 2942.0438357533885, 3026.803257788237, 3508.8421021054114, 28374.0, 28500.429991400262, 28763.0, 29140.125796226148, 29408.41183176346, 2994.550817377389, 3036.7722420818527, 3041.2700951771635, 3046.6191726034244, 3134.8432578371217, 239427.0, 240379.0, 240570.0, 240603.0, 240944.0, 49813.50186498161, 50717.746411267704, 50734.0, 50734.746326268134, 50754.74622626863, 57413.84223867727, 58378.0, 58444.0, 58464.4153558459, 58518.0, 11615.6515304541, 11659.358735269472, 11690.824637630443, 11729.589464368706, 11731.589394371156, 10318.17454603645, 10359.844602330972, 10384.896151038543, 10418.895811041944, 10436.73908152287, 17400.91299543494, 17459.825401746075, 17538.912305438393, 17938.5515362117, 18161.0, 7431.8142046449275, 7683.769486915401, 7711.8792332108, 7716.498427602301, 7740.3420709240345, 798.3932211519287, 814.5642081486495, 829.2288172000098, 882.5895958379256, 919.3564504846634, 26679.599806002927, 26713.19860404191, 26750.866245668647, 26861.179576144616, 26874.193774186806, 891.8795962545103, 912.9224015958717, 935.9719208423758, 937.9963439120212, 1049.0925349572565, 11692.240004399857, 11747.060235181165, 11749.412529373498, 11763.117766167401, 11811.881881181078, 273355.0, 274817.0, 275976.0, 277552.0, 278601.0, 44948.3257751134, 45078.0, 45116.77441612771, 45139.0, 45224.321635175496, 1092.6940456672144, 1099.4777480696764, 1109.7281166114353, 1110.2672236323988, 1171.2094336323119, 22972.4256893579, 23409.41476463034, 23444.64833027472, 23677.881610592525, 25594.232173034838, 35188.29623407466, 35278.47082293716, 35340.11649708778, 35355.46966795551, 35484.29031419409, 181072.0, 181074.0, 183144.0, 184081.0, 184193.0, 24569.63145552854, 25053.248402547953, 27162.32094197661, 27748.44503109967, 27936.30159246035, 34329.828350858086, 34416.139596510286, 34664.13339666528, 34903.82548087243, 34962.20302375753, 27609.598914610393, 27761.58357624597, 28036.43927121487, 29703.702962970958, 29730.0, 32711.0, 32877.34245315128, 33335.0, 33499.665003349655, 33514.664853351154, 27639.30901727473, 28119.156425307272, 35847.46228806622, 36069.45895811512, 36447.45328820123, 33685.66314336923, 36722.26555468929, 36932.0, 36949.261014780095, 36965.63034369622, 26385.868070659522, 27024.59463108094, 27468.56642919635, 28052.85973570119, 29145.0], "prototype.html": [275.69948755856115, 278.92469033360993, 283.22820314642604, 288.5311369025334, 289.5699885669779, 5355.08963476209, 5373.328333958255, 5401.3248343957, 5434.646747961379, 5442.8911421771545, 5032.748362581875, 5156.845294641157, 5189.299444574981, 5277.762500687469, 5334.119870221409, 4006.579309172524, 4035.4955630546183, 4053.574374690659, 4064.1871625674985, 4075.3886916962397, 3894.766314021168, 4053.108316170438, 4063.0, 4064.817083231247, 4066.4713587233764, 3912.4326972588956, 3960.881173564798, 4015.2973229684835, 4021.5978402159844, 4048.9595104048876, 4015.6586690131376, 4016.3172260715746, 4024.6579040781567, 4025.215083058805, 4031.838726450953, 3489.3370259650837, 3492.4237500812337, 3494.8077855717925, 3495.388307046282, 3496.7202623790035, 5090.465501122403, 5092.490750924915, 5093.898122037538, 5094.261332106824, 5100.234964755279, 4516.277395616686, 4563.612092972101, 4626.306054091913, 4633.536646335339, 4634.629229661619, 5570.359408668014, 5576.832695019156, 5579.7489112990015, 5581.8604534886545, 5584.86037849057, 3803.4976184407283, 3806.2197249563774, 3806.4290356446754, 3806.5622453417936, 3813.923721525554, 5836.5914385993, 5851.180834683105, 5860.238169038041, 5863.237779088734, 5870.7945221917025, 3817.541894972621, 3912.374020156761, 3916.667083297895, 3927.273454410943, 3936.2127574485216, 3974.761514309093, 3982.960170398259, 3983.14362412077, 3984.7409918355215, 3984.820683069269, 4593.058423023273, 4600.5629465200755, 4604.907901842012, 4608.101420223092, 4612.0545288215835, 5588.189712491666, 5592.692401917852, 5593.356763972195, 5597.608167428241, 5601.327840659147, 1329.7739384304691, 1395.8813500852339, 1401.6565941344436, 1402.5301523989579, 1404.592668126232, 885.84054870124, 886.7650072730731, 899.1008991008991, 902.873597696323, 903.1465265324337, 4903.53416425439, 4931.087748766489, 4935.777889994959, 4939.0, 4943.134951383566, 5754.856128596735, 5755.913661295084, 5756.021476348947, 5758.424157584292, 5764.394738552392, 4783.5933945614315, 4854.927176092361, 4927.655064145475, 4930.235813448921, 4935.358403407534, 3105.4254962831947, 3129.4523458394688, 3137.215696075981, 3141.607299087614, 3142.8114313140827, 5555.583331250173, 5567.721613919369, 5573.191887176336, 5573.331200255995, 5573.860653483695, 6004.189434426384, 6006.759729610854, 6008.158857759917, 6011.909821352683, 6024.1265016573225, 5409.756560954766, 5580.0, 5588.161775733673, 5592.273004509307, 5598.664080155204, 5795.507381872588, 5846.795362162304, 5858.062709966385, 5860.443257890493, 5865.149553314831, 5705.543556515552, 5719.8570035749435, 5727.8568035799435, 5728.6562806230095, 5744.052231381942, 5391.784328626811, 5567.47109024642, 5579.386267510652, 5581.6371935824045, 5583.972080139573, 3920.2747491714126, 3967.6032396760093, 3971.900702482461, 3974.0, 3977.3636218204947, 5788.739506722123, 5800.187973683604, 5800.883982320245, 5801.912971305349, 5802.883942321215, 5590.217369568345, 5595.216669666169, 5595.888082238251, 5600.915986260291, 5608.523275521627, 5431.375391829832, 5615.831525054255, 5634.380218176079, 5638.88722225545, 5639.689817060101, 5477.096279113902, 5482.205080263419, 5490.313710786152, 5496.285482887199, 5499.587530935276, 5671.914921276101, 5674.233978412862, 5682.460166284196, 5684.033714268667, 5685.147227915846, 5409.702466364388, 5535.391106978149, 5540.695261760642, 5546.750396232099, 5551.444855514416], "yui.html": [632.0708558419122, 649.0685865782599, 649.1107183159072, 656.9868602627947, 769.3652736492395, 11420.200585958986, 11746.471408786614, 11771.352575608349, 13302.334883255822, 13704.246266455366, 11803.763924721501, 11875.465604047817, 11897.524099036049, 11910.702232444193, 11919.225250358742, 592.6651441935314, 600.6696317025641, 756.1946526948796, 761.6724808332415, 763.5380594740158, 745.4260219630908, 750.1972889008763, 760.0499375780274, 760.1790066727921, 760.5930827007552, 660.9239937407187, 663.3366633366634, 663.3764261594087, 663.5554178700258, 663.8108139180334, 618.0883197284015, 623.6756886419082, 623.7068577768441, 651.9087327774115, 768.8500742355243, 561.4161272276868, 568.897598432282, 572.1703529881646, 572.7909313100688, 573.6758731316793, 11859.644210673694, 12126.939365303117, 12133.93933030338, 12143.392830358534, 12144.089193310538, 8958.776030599221, 9143.222826059726, 9313.534323283877, 9700.126988571063, 9744.464054477, 8733.7816554586, 9019.549022548912, 9184.081591840762, 9226.90773092274, 9353.971063183044, 2748.244232835986, 2797.7621902138344, 2890.8843646254127, 2940.911772646824, 2977.0622253989923, 39295.21409571793, 39632.801835990635, 39730.20539589192, 39738.80130599358, 39749.0, 9267.472548305535, 9311.208547273558, 9363.391379560308, 9585.329026968046, 9590.376625519319, 16429.342826286815, 17015.82984170167, 17030.659386812444, 17034.97790132596, 17068.573285667957, 6105.32841387447, 6456.0961465394885, 6506.60960342381, 6531.771388001397, 6694.230163531159, 3556.7510274280553, 3631.6913062389995, 3631.763935344194, 3649.908752281161, 3654.926901462009, 2709.5529237675955, 2734.0567504211017, 2739.7260273972443, 2742.287005378616, 2744.0395861448333, 397.7653184621087, 408.75533998973197, 411.54935345796304, 413.9958600414017, 414.349471330009, 351.3254551261584, 356.01739199808713, 375.5812269319689, 395.07355251934166, 414.32051435645565, 6746.22418421878, 7078.823029424203, 7199.964000179965, 7286.198518162998, 7314.707411703579, 460.61538615255967, 479.84884761300077, 521.7860677122437, 530.2046929605592, 534.3187436019107, 3233.7898036627544, 3302.5871766029245, 3309.8841540545964, 3398.9490157647656, 3406.9659303407143, 46188.5381146191, 46331.0, 47110.29334559984, 49305.26042109371, 49399.50600494021, 41260.587394126276, 41602.95992600209, 41729.165416691496, 43834.12331753347, 45732.0, 41737.791311042645, 42256.15487690229, 42492.150156997304, 42777.35833962493, 43112.137757245306, 6974.267701891228, 7544.4341674373545, 7565.962170189114, 7601.3918886487845, 7637.427192960439, 31678.0, 32257.354852902343, 32264.35373809527, 32402.027939161864, 32751.508727368633, 37583.0, 39094.4135837957, 41646.37530437107, 42503.3624495639, 42689.0, 5957.791477298274, 6098.512119030378, 6110.388961104032, 6186.628802271878, 6396.584222025554, 10375.740606484898, 10386.376817390981, 10447.111995480469, 10560.894391055992, 10850.945745271223, 9718.514074296398, 9932.354396964174, 9960.402375857471, 10169.694909152737, 10225.693229203136, 9887.653932112342, 9899.25187032419, 9956.601735930482, 9995.20038396941, 10016.39901605906, 8134.715284965235, 8330.541820199947, 8602.956985215034, 8608.354373421893, 8811.735647930573, 7880.763577092696, 8245.422820402515, 8403.663853445794, 8607.48355098696, 8616.267617252604, 8005.759827205193, 8126.593670316579, 8144.267015968591, 8217.5480348579, 8368.24685778283]}, "summary": {"lowerIsBetter": false, "suite": 5827.199030705657, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5955.409378110659, "unit": "ms", "value": 5955.409378110659}, "dojo.html": {"lowerIsBetter": false, "filtered": 4659.078012942488, "unit": "ms", "value": 4659.078012942488}, "mootools.html": {"lowerIsBetter": false, "filtered": 3902.4533672668754, "unit": "ms", "value": 3902.4533672668754}, "ext.html": {"lowerIsBetter": false, "filtered": 16509.371688239728, "unit": "ms", "value": 16509.371688239728}, "prototype.html": {"lowerIsBetter": false, "filtered": 4161.110160537406, "unit": "ms", "value": 4161.110160537406}, "yui.html": {"lowerIsBetter": false, "filtered": 5262.91785826014, "unit": "ms", "value": 5262.91785826014}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447762212, "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": "20151117030105", "branch": "Firefox-Non-PGO", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 163.0, 164.0, 163.0], "ai-astar": [110.0, 114.0, 105.0, 113.0, 112.0, 111.0, 101.0, 111.0, 115.0, 111.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [155.0, 131.0, 155.0, 164.0, 131.0, 156.0, 151.0, 132.0, 175.0, 130.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 75.0, 68.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [163.0, 149.0, 148.0, 148.0, 153.0, 139.0, 150.0, 165.0, 138.0, 137.0], "json-parse-financial": [69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 78.0, 66.0, 68.0], "stanford-crypto-sha256-iterative": [72.0, 73.0, 73.0, 70.0, 72.0, 73.0, 71.0, 70.0, 70.0, 71.0], "audio-fft": [73.0, 73.0, 80.0, 95.0, 72.0, 73.0, 72.0, 101.0, 89.0, 73.0], "imaging-darkroom": [148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [127.0, 128.0, 117.0, 120.0, 128.0, 125.0, 124.0, 129.0, 128.0, 120.0], "audio-oscillator": [92.0, 92.0, 130.0, 91.0, 92.0, 93.0, 128.0, 92.0, 93.0, 126.0], "stanford-crypto-aes": [82.0, 92.0, 84.0, 83.0, 85.0, 82.0, 84.0, 84.0, 83.0, 82.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1523.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.1, "unit": "ms", "value": 80.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.0, "unit": "ms", "value": 149.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.6, "unit": "ms", "value": 124.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.4, "unit": "ms", "value": 147.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.3, "unit": "ms", "value": 110.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.5, "unit": "ms", "value": 71.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "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-045"}, "testrun": {"date": 1447762212, "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": "20151117030105", "branch": "Firefox-Non-PGO", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.3816852635629], "Encrypt": [290.1073397156948], "NavierStokes": [4830.917874396136], "Decrypt": [5015.0], "Splay": [597.7286312014345], "Richards": [165.78249336870027], "RegExp": [26921.052631578947], "Earley": [833.3333333333334], "Boyer": [11882.35294117647], "RayTrace": [2000.0]}, "summary": {"lowerIsBetter": false, "suite": 19678.325878242344, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 343.681364, "unit": "score", "value": 343.681364}, "Encrypt": {"lowerIsBetter": false, "filtered": 917.5259069999997, "unit": "score", "value": 917.5259069999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.07696909272185, "unit": "score", "value": 53.07696909272185}, "Splay": {"lowerIsBetter": false, "filtered": 136.33444300000005, "unit": "score", "value": 136.33444300000005}, "RegExp": {"lowerIsBetter": false, "filtered": 33.83913000977518, "unit": "score", "value": 33.83913000977518}, "Richards": {"lowerIsBetter": false, "filtered": 212.94166399999992, "unit": "score", "value": 212.94166399999992}, "Earley": {"lowerIsBetter": false, "filtered": 799.7556000000001, "unit": "score", "value": 799.7556000000001}, "Boyer": {"lowerIsBetter": false, "filtered": 56.08847029702973, "unit": "score", "value": 56.08847029702973}, "RayTrace": {"lowerIsBetter": false, "filtered": 369.9945, "unit": "score", "value": 369.9945}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447762212, "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": "20151117030105", "branch": "Firefox-Non-PGO", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}] 04:30:29 INFO - RETURN: dromaeo_css: 5827.20 04:30:29 INFO - RETURN: kraken: 1523.10 04:30:29 INFO - RETURN: v8_7: 19678.33 04:30:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19678.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5827.20"}}} 04:30:29 INFO - Return code: 0 04:30:29 INFO - # TBPL SUCCESS # 04:30:29 INFO - Running post-action listener: _resource_record_post_action 04:30:29 INFO - Running post-run listener: _resource_record_post_run 04:30:31 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509169664; Read time: 12; Write time: 606960 04:30:31 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 163688448; Read time: 0; Write time: 223260 04:30:31 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288657408; Read time: 12; Write time: 201592 04:30:31 INFO - Running post-run listener: _upload_blobber_files 04:30:31 INFO - Blob upload gear active. 04:30:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:30:31 INFO - Copying logs to upload dir... 04:30:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.416386 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-17 04:30:30.685659) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:30:30.689622) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010078 build_url: 'https://queue.taskcluster.net/v1/task/VQmT1j56TOuju97AqWiWPA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:30:30.745433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:30:30.745765) ========= 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=61fa6ed41387771909ec0f71000001b3-1447762160.882599-139292266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:30:30.795785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:30:30.796163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:30:30.796561) ========= ========= Total master_lag: 0.23 =========