builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1450540473.77 results: success (0) buildid: 20151219070815 builduid: fcfbebcc98f6435a91302dbe75949d28 revision: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.773371) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.773808) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.774150) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.815347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.815661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.856207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.856583) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.906222) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.906558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.906957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:33.907248) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-19 07:54:34-- 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% 220M=0s 2015-12-19 07:54:34 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176104 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.096911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.097225) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.148046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.148429) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ef961a0fe82f1b2938dcaa47f9911f5de0d08109 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ef961a0fe82f1b2938dcaa47f9911f5de0d08109 --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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-19 07:54:34,470 truncating revision to first 12 chars 2015-12-19 07:54:34,470 Setting DEBUG logging. 2015-12-19 07:54:34,470 attempt 1/10 2015-12-19 07:54:34,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ef961a0fe82f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-19 07:54:34,804 unpacking tar archive at: b2g-inbound-ef961a0fe82f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.812533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.812851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.822215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.822517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 07:54:34.822948) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-19 07:54:34.823260) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:54:35 INFO - MultiFileLogger online at 20151219 07:54:35 in /builds/slave/test 07:54:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 07:54:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:35 INFO - {'append_to_log': False, 07:54:35 INFO - 'base_work_dir': '/builds/slave/test', 07:54:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 07:54:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 07:54:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:35 INFO - 'config_files': ('talos/linux_config.py',), 07:54:35 INFO - 'default_actions': ('clobber', 07:54:35 INFO - 'read-buildbot-config', 07:54:35 INFO - 'download-and-extract', 07:54:35 INFO - 'populate-webroot', 07:54:35 INFO - 'create-virtualenv', 07:54:35 INFO - 'install', 07:54:35 INFO - 'run-tests'), 07:54:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:35 INFO - 'download_minidump_stackwalk': True, 07:54:35 INFO - 'download_symbols': 'ondemand', 07:54:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:35 INFO - 'installer_path': 'installer.exe', 07:54:35 INFO - 'log_level': 'info', 07:54:35 INFO - 'log_name': 'talos', 07:54:35 INFO - 'log_to_console': True, 07:54:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:54:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:54:35 INFO - 'opt_config_files': (), 07:54:35 INFO - 'pip_index': False, 07:54:35 INFO - 'sps_profile': False, 07:54:35 INFO - 'sps_profile_interval': 0, 07:54:35 INFO - 'suite': 'dromaeojs', 07:54:35 INFO - 'system_bits': '64', 07:54:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:35 INFO - 'title': 'talos-linux64-ix-069', 07:54:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:35 INFO - 'use_talos_json': True, 07:54:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:35 INFO - 'work_dir': 'build'} 07:54:35 INFO - ##### 07:54:35 INFO - ##### Running clobber step. 07:54:35 INFO - ##### 07:54:35 INFO - Running pre-action listener: _resource_record_pre_action 07:54:35 INFO - Running main action method: clobber 07:54:35 INFO - rmtree: /builds/slave/test/build 07:54:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:36 INFO - Running post-action listener: _resource_record_post_action 07:54:36 INFO - ##### 07:54:36 INFO - ##### Running read-buildbot-config step. 07:54:36 INFO - ##### 07:54:36 INFO - Running pre-action listener: _resource_record_pre_action 07:54:36 INFO - Running main action method: read_buildbot_config 07:54:36 INFO - Using buildbot properties: 07:54:36 INFO - { 07:54:36 INFO - "project": "", 07:54:36 INFO - "product": "firefox", 07:54:36 INFO - "script_repo_revision": "production", 07:54:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:54:36 INFO - "repository": "", 07:54:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 07:54:36 INFO - "buildid": "20151219070815", 07:54:36 INFO - "pgo_build": "False", 07:54:36 INFO - "basedir": "/builds/slave/test", 07:54:36 INFO - "buildnumber": 312, 07:54:36 INFO - "slavename": "talos-linux64-ix-069", 07:54:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:54:36 INFO - "platform": "ubuntu64_hw", 07:54:36 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 07:54:36 INFO - "branch": "b2g-inbound", 07:54:36 INFO - "repo_path": "integration/b2g-inbound", 07:54:36 INFO - "revision": "ef961a0fe82f1b2938dcaa47f9911f5de0d08109", 07:54:36 INFO - "stage_platform": "linux64", 07:54:36 INFO - "builduid": "fcfbebcc98f6435a91302dbe75949d28", 07:54:36 INFO - "slavebuilddir": "test" 07:54:36 INFO - } 07:54:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:54:36 INFO - Running post-action listener: _resource_record_post_action 07:54:36 INFO - ##### 07:54:36 INFO - ##### Running download-and-extract step. 07:54:36 INFO - ##### 07:54:36 INFO - Running pre-action listener: _resource_record_pre_action 07:54:36 INFO - Running main action method: download_and_extract 07:54:36 INFO - mkdir: /builds/slave/test/build/tests 07:54:36 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')]} 07:54:36 INFO - https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/test_packages.json 07:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/test_packages.json 07:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:54:37 INFO - Downloaded 1302 bytes. 07:54:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:54:37 INFO - Using the following test package requirements: 07:54:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:54:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'jsshell-linux-x86_64.zip'], 07:54:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:54:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:54:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:54:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:54:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:54:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:54: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')]} 07:54:37 INFO - https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:54:38 INFO - Downloaded 21872165 bytes. 07:54:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:54:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:54:40 INFO - Return code: 0 07:54:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:40 INFO - https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:54:41 INFO - Downloaded 21872165 bytes. 07:54:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:54:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:54:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:54:42 INFO - Return code: 0 07:54: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')]} 07:54:42 INFO - https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:54:43 INFO - Downloaded 11132039 bytes. 07:54:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:54:44 INFO - Return code: 0 07:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:44 INFO - https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:54:45 INFO - Downloaded 53023739 bytes. 07:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:54:45 INFO - mkdir: /builds/slave/test/properties 07:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:45 INFO - Contents: 07:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:54:45 INFO - Running post-action listener: _resource_record_post_action 07:54:45 INFO - Running post-action listener: set_extra_try_arguments 07:54:45 INFO - ##### 07:54:45 INFO - ##### Running populate-webroot step. 07:54:45 INFO - ##### 07:54:45 INFO - Running pre-action listener: _resource_record_pre_action 07:54:45 INFO - Running main action method: populate_webroot 07:54:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:45 INFO - '--tppagecycles', 07:54:45 INFO - '7'], 07:54:45 INFO - 'tests': ['tsvgm']}}, 07:54:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:54:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:54:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:54:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'tests': ['damp', 'tps']}, 07:54:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['damp', 'tps']}, 07:54:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:54:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:45 INFO - 'other': {'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'other_l64': {'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'other_nol64': {'tests': ['a11yr', 07:54:45 INFO - 'ts_paint', 07:54:45 INFO - 'tpaint', 07:54:45 INFO - 'sessionrestore', 07:54:45 INFO - 'sessionrestore_no_auto_restore']}, 07:54:45 INFO - 'svgr': {'tests': ['tsvgx', 07:54:45 INFO - 'tsvgr_opacity', 07:54:45 INFO - 'tart', 07:54:45 INFO - 'tscrollx', 07:54:45 INFO - 'cart']}, 07:54:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['tsvgx', 07:54:45 INFO - 'tsvgr_opacity', 07:54:45 INFO - 'tart', 07:54:45 INFO - 'tscrollx', 07:54:45 INFO - 'cart']}, 07:54:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'tests': ['tp5o']}, 07:54:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'talos_options': ['--e10s'], 07:54:45 INFO - 'tests': ['tp5o']}, 07:54:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'talos_options': ['--xperf_path', 07:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:45 INFO - 'tests': ['tp5n']}, 07:54:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:45 INFO - 'talos_options': ['--e10s', 07:54:45 INFO - '--xperf_path', 07:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:45 INFO - 'tests': ['tp5n']}}, 07:54:45 INFO - 'talos.zip': {'path': '', 07:54:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:45 INFO - Running post-action listener: _resource_record_post_action 07:54:45 INFO - ##### 07:54:45 INFO - ##### Running create-virtualenv step. 07:54:45 INFO - ##### 07:54:45 INFO - Running pre-action listener: _resource_record_pre_action 07:54:45 INFO - Running main action method: create_virtualenv 07:54:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:45 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 07:54:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:45 INFO - Using real prefix '/usr' 07:54:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:48 INFO - Installing pip.................done. 07:54:48 INFO - Return code: 0 07:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:48 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')]} 07:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:48 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')]} 07:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:48 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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:48 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 07:54:48 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 07:54:48 INFO - Using env: {'DISPLAY': ':0', 07:54:48 INFO - 'HOME': '/home/cltbld', 07:54:48 INFO - 'LANG': 'en_US.UTF-8', 07:54:48 INFO - 'LANGUAGE': 'en_US:en', 07:54:48 INFO - 'LOGNAME': 'cltbld', 07:54:48 INFO - 'MAIL': '/var/mail/cltbld', 07:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:48 INFO - 'MOZ_NO_REMOTE': '1', 07:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:48 INFO - 'NO_EM_RESTART': '1', 07:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:48 INFO - 'PWD': '/builds/slave/test', 07:54:48 INFO - 'SHELL': '/bin/bash', 07:54:48 INFO - 'SHLVL': '1', 07:54:48 INFO - 'TERM': 'linux', 07:54:48 INFO - 'TMOUT': '86400', 07:54:48 INFO - 'USER': 'cltbld', 07:54:48 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:48 INFO - '_': '/tools/buildbot/bin/python'} 07:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:48 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 07:54:48 INFO - Cleaning up... 07:54:48 INFO - Return code: 0 07:54:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:54:48 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')]} 07:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:48 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')]} 07:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:48 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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:48 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 07:54:48 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 07:54:48 INFO - Using env: {'DISPLAY': ':0', 07:54:48 INFO - 'HOME': '/home/cltbld', 07:54:48 INFO - 'LANG': 'en_US.UTF-8', 07:54:48 INFO - 'LANGUAGE': 'en_US:en', 07:54:48 INFO - 'LOGNAME': 'cltbld', 07:54:48 INFO - 'MAIL': '/var/mail/cltbld', 07:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:48 INFO - 'MOZ_NO_REMOTE': '1', 07:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:48 INFO - 'NO_EM_RESTART': '1', 07:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:48 INFO - 'PWD': '/builds/slave/test', 07:54:48 INFO - 'SHELL': '/bin/bash', 07:54:48 INFO - 'SHLVL': '1', 07:54:48 INFO - 'TERM': 'linux', 07:54:48 INFO - 'TMOUT': '86400', 07:54:48 INFO - 'USER': 'cltbld', 07:54:48 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:48 INFO - '_': '/tools/buildbot/bin/python'} 07:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:48 INFO - Downloading/unpacking psutil>=0.7.1 07:54:48 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 07:54:48 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 07:54:48 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 07:54:48 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 07:54:48 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 07:54:48 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 07:54:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:54:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:50 INFO - Installing collected packages: psutil 07:54:50 INFO - Running setup.py install for psutil 07:54:50 INFO - building 'psutil._psutil_linux' extension 07:54:50 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 07:54:50 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 07:54:50 INFO - building 'psutil._psutil_posix' extension 07:54:50 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 07:54:50 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 07:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:50 INFO - Successfully installed psutil 07:54:50 INFO - Cleaning up... 07:54:51 INFO - Return code: 0 07:54:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:51 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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:51 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 07:54:51 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 07:54:51 INFO - Using env: {'DISPLAY': ':0', 07:54:51 INFO - 'HOME': '/home/cltbld', 07:54:51 INFO - 'LANG': 'en_US.UTF-8', 07:54:51 INFO - 'LANGUAGE': 'en_US:en', 07:54:51 INFO - 'LOGNAME': 'cltbld', 07:54:51 INFO - 'MAIL': '/var/mail/cltbld', 07:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:51 INFO - 'MOZ_NO_REMOTE': '1', 07:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:51 INFO - 'NO_EM_RESTART': '1', 07:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:51 INFO - 'PWD': '/builds/slave/test', 07:54:51 INFO - 'SHELL': '/bin/bash', 07:54:51 INFO - 'SHLVL': '1', 07:54:51 INFO - 'TERM': 'linux', 07:54:51 INFO - 'TMOUT': '86400', 07:54:51 INFO - 'USER': 'cltbld', 07:54:51 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:51 INFO - '_': '/tools/buildbot/bin/python'} 07:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:51 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 07:54:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:54:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:54:52 INFO - Installing collected packages: mozsystemmonitor 07:54:52 INFO - Running setup.py install for mozsystemmonitor 07:54:53 INFO - Successfully installed mozsystemmonitor 07:54:53 INFO - Cleaning up... 07:54:53 INFO - Return code: 0 07:54:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', '--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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:53 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 07:54:53 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 07:54:53 INFO - Using env: {'DISPLAY': ':0', 07:54:53 INFO - 'HOME': '/home/cltbld', 07:54:53 INFO - 'LANG': 'en_US.UTF-8', 07:54:53 INFO - 'LANGUAGE': 'en_US:en', 07:54:53 INFO - 'LOGNAME': 'cltbld', 07:54:53 INFO - 'MAIL': '/var/mail/cltbld', 07:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:53 INFO - 'MOZ_NO_REMOTE': '1', 07:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:53 INFO - 'NO_EM_RESTART': '1', 07:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:53 INFO - 'PWD': '/builds/slave/test', 07:54:53 INFO - 'SHELL': '/bin/bash', 07:54:53 INFO - 'SHLVL': '1', 07:54:53 INFO - 'TERM': 'linux', 07:54:53 INFO - 'TMOUT': '86400', 07:54:53 INFO - 'USER': 'cltbld', 07:54:53 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:53 INFO - '_': '/tools/buildbot/bin/python'} 07:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:53 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 07:54:53 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 07:54:53 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 07:54:53 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 07:54:53 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 07:54:53 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 07:54:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:55 INFO - Downloading docopt-0.6.1.tar.gz 07:54:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:55 INFO - Running setup.py install for blobuploader 07:54:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:55 INFO - Running setup.py install for requests 07:54:56 INFO - Running setup.py install for docopt 07:54:56 INFO - Successfully installed blobuploader requests docopt 07:54:56 INFO - Cleaning up... 07:54:56 INFO - Return code: 0 07:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:56 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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:56 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 07:54:56 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 07:54:56 INFO - Using env: {'DISPLAY': ':0', 07:54:56 INFO - 'HOME': '/home/cltbld', 07:54:56 INFO - 'LANG': 'en_US.UTF-8', 07:54:56 INFO - 'LANGUAGE': 'en_US:en', 07:54:56 INFO - 'LOGNAME': 'cltbld', 07:54:56 INFO - 'MAIL': '/var/mail/cltbld', 07:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:56 INFO - 'MOZ_NO_REMOTE': '1', 07:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:56 INFO - 'NO_EM_RESTART': '1', 07:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:56 INFO - 'PWD': '/builds/slave/test', 07:54:56 INFO - 'SHELL': '/bin/bash', 07:54:56 INFO - 'SHLVL': '1', 07:54:56 INFO - 'TERM': 'linux', 07:54:56 INFO - 'TMOUT': '86400', 07:54:56 INFO - 'USER': 'cltbld', 07:54:56 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:56 INFO - '_': '/tools/buildbot/bin/python'} 07:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:56 INFO - Running setup.py (path:/tmp/pip-ExjLYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:56 INFO - Running setup.py (path:/tmp/pip-P9M48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:56 INFO - Running setup.py (path:/tmp/pip-4rZt7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:56 INFO - Running setup.py (path:/tmp/pip-Zct1QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:56 INFO - Running setup.py (path:/tmp/pip-FRfVNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:56 INFO - Running setup.py (path:/tmp/pip-Qdy5gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:56 INFO - Running setup.py (path:/tmp/pip-fB1hOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:57 INFO - Running setup.py (path:/tmp/pip-icqmN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:57 INFO - Running setup.py (path:/tmp/pip-SrpH5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:57 INFO - Running setup.py (path:/tmp/pip-zsgAdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:57 INFO - Running setup.py (path:/tmp/pip-utCBRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:57 INFO - Running setup.py (path:/tmp/pip-xCkVRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:57 INFO - Running setup.py (path:/tmp/pip-CE1OYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:57 INFO - Running setup.py (path:/tmp/pip-EV0gdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:57 INFO - Running setup.py (path:/tmp/pip-thVMhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:57 INFO - Running setup.py (path:/tmp/pip-HSlcll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:57 INFO - Running setup.py (path:/tmp/pip-qsNqmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:57 INFO - Running setup.py install for manifestparser 07:54:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:57 INFO - Running setup.py install for mozcrash 07:54:57 INFO - Running setup.py install for mozdebug 07:54:58 INFO - Running setup.py install for mozdevice 07:54:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for mozfile 07:54:58 INFO - Running setup.py install for mozhttpd 07:54:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for mozinfo 07:54:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for mozInstall 07:54:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for mozleak 07:54:58 INFO - Running setup.py install for mozlog 07:54:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for moznetwork 07:54:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:58 INFO - Running setup.py install for mozprocess 07:54:58 INFO - Running setup.py install for mozprofile 07:54:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:59 INFO - Running setup.py install for mozrunner 07:54:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:59 INFO - Running setup.py install for mozscreenshot 07:54:59 INFO - Running setup.py install for moztest 07:54:59 INFO - Running setup.py install for mozversion 07:54:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:59 INFO - Cleaning up... 07:54:59 INFO - Return code: 0 07:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:54:59 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 07:54:59 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 07:54:59 INFO - Using env: {'DISPLAY': ':0', 07:54:59 INFO - 'HOME': '/home/cltbld', 07:54:59 INFO - 'LANG': 'en_US.UTF-8', 07:54:59 INFO - 'LANGUAGE': 'en_US:en', 07:54:59 INFO - 'LOGNAME': 'cltbld', 07:54:59 INFO - 'MAIL': '/var/mail/cltbld', 07:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:59 INFO - 'MOZ_NO_REMOTE': '1', 07:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:59 INFO - 'NO_EM_RESTART': '1', 07:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:59 INFO - 'PWD': '/builds/slave/test', 07:54:59 INFO - 'SHELL': '/bin/bash', 07:54:59 INFO - 'SHLVL': '1', 07:54:59 INFO - 'TERM': 'linux', 07:54:59 INFO - 'TMOUT': '86400', 07:54:59 INFO - 'USER': 'cltbld', 07:54:59 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:59 INFO - '_': '/tools/buildbot/bin/python'} 07:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:59 INFO - Running setup.py (path:/tmp/pip-GOnccm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:59 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)) 07:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:59 INFO - Running setup.py (path:/tmp/pip-dRzBEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:59 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)) 07:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:59 INFO - Running setup.py (path:/tmp/pip-SsSM2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:59 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)) 07:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:59 INFO - Running setup.py (path:/tmp/pip-hwkPmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:00 INFO - Running setup.py (path:/tmp/pip-5QaJoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:00 INFO - Running setup.py (path:/tmp/pip-cn2_lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:00 INFO - Running setup.py (path:/tmp/pip-rmIZYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:00 INFO - Running setup.py (path:/tmp/pip-FEefHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:00 INFO - Running setup.py (path:/tmp/pip-hsoGaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:00 INFO - Running setup.py (path:/tmp/pip-QACCpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:00 INFO - Running setup.py (path:/tmp/pip-ws4UN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:00 INFO - Running setup.py (path:/tmp/pip-wYxnxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:00 INFO - Running setup.py (path:/tmp/pip-p9gJ0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:00 INFO - Running setup.py (path:/tmp/pip-bG8OFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:00 INFO - Running setup.py (path:/tmp/pip-jK0sbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:00 INFO - Running setup.py (path:/tmp/pip-NQftED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:00 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)) 07:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:00 INFO - Running setup.py (path:/tmp/pip-lEFPft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:00 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)) 07:55:00 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)) 07:55:00 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)) 07:55:00 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)) 07:55:00 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)) 07:55:00 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)) 07:55:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:00 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 07:55:00 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 07:55:00 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 07:55:00 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 07:55:00 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 07:55:00 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 07:55:02 INFO - Downloading blessings-1.5.1.tar.gz 07:55:02 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 07:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:02 INFO - Installing collected packages: blessings 07:55:02 INFO - Running setup.py install for blessings 07:55:02 INFO - Successfully installed blessings 07:55:02 INFO - Cleaning up... 07:55:02 INFO - Return code: 0 07:55:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:03 INFO - Reading from file tmpfile_stdout 07:55:03 INFO - Current package versions: 07:55:03 INFO - argparse == 1.2.1 07:55:03 INFO - blessings == 1.5.1 07:55:03 INFO - blobuploader == 1.2.4 07:55:03 INFO - docopt == 0.6.1 07:55:03 INFO - manifestparser == 1.1 07:55:03 INFO - mozInstall == 1.12 07:55:03 INFO - mozcrash == 0.16 07:55:03 INFO - mozdebug == 0.1 07:55:03 INFO - mozdevice == 0.47 07:55:03 INFO - mozfile == 1.2 07:55:03 INFO - mozhttpd == 0.7 07:55:03 INFO - mozinfo == 0.9 07:55:03 INFO - mozleak == 0.1 07:55:03 INFO - mozlog == 3.1 07:55:03 INFO - moznetwork == 0.27 07:55:03 INFO - mozprocess == 0.22 07:55:03 INFO - mozprofile == 0.27 07:55:03 INFO - mozrunner == 6.11 07:55:03 INFO - mozscreenshot == 0.1 07:55:03 INFO - mozsystemmonitor == 0.0 07:55:03 INFO - moztest == 0.7 07:55:03 INFO - mozversion == 1.4 07:55:03 INFO - psutil == 3.1.1 07:55:03 INFO - requests == 1.2.3 07:55:03 INFO - wsgiref == 0.1.2 07:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:55:03 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 07:55:03 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 07:55:03 INFO - Using env: {'DISPLAY': ':0', 07:55:03 INFO - 'HOME': '/home/cltbld', 07:55:03 INFO - 'LANG': 'en_US.UTF-8', 07:55:03 INFO - 'LANGUAGE': 'en_US:en', 07:55:03 INFO - 'LOGNAME': 'cltbld', 07:55:03 INFO - 'MAIL': '/var/mail/cltbld', 07:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:03 INFO - 'MOZ_NO_REMOTE': '1', 07:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:03 INFO - 'NO_EM_RESTART': '1', 07:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:03 INFO - 'PWD': '/builds/slave/test', 07:55:03 INFO - 'SHELL': '/bin/bash', 07:55:03 INFO - 'SHLVL': '1', 07:55:03 INFO - 'TERM': 'linux', 07:55:03 INFO - 'TMOUT': '86400', 07:55:03 INFO - 'USER': 'cltbld', 07:55:03 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:03 INFO - '_': '/tools/buildbot/bin/python'} 07:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 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)) 07:55:03 INFO - Cleaning up... 07:55:03 INFO - Return code: 0 07:55:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:55:03 INFO - Using env: {'DISPLAY': ':0', 07:55:03 INFO - 'HOME': '/home/cltbld', 07:55:03 INFO - 'LANG': 'en_US.UTF-8', 07:55:03 INFO - 'LANGUAGE': 'en_US:en', 07:55:03 INFO - 'LOGNAME': 'cltbld', 07:55:03 INFO - 'MAIL': '/var/mail/cltbld', 07:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:03 INFO - 'MOZ_NO_REMOTE': '1', 07:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:03 INFO - 'NO_EM_RESTART': '1', 07:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:03 INFO - 'PWD': '/builds/slave/test', 07:55:03 INFO - 'SHELL': '/bin/bash', 07:55:03 INFO - 'SHLVL': '1', 07:55:03 INFO - 'TERM': 'linux', 07:55:03 INFO - 'TMOUT': '86400', 07:55:03 INFO - 'USER': 'cltbld', 07:55:03 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:03 INFO - '_': '/tools/buildbot/bin/python'} 07:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:03 INFO - Downloading/unpacking jsonschema 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:55:05 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:05 INFO - warning: no files found matching '*.txt' 07:55:05 INFO - no previously-included directories found matching 'build' 07:55:05 INFO - no previously-included directories found matching 'dist' 07:55:05 INFO - no previously-included directories found matching '.git*' 07:55:05 INFO - Installing collected packages: jsonschema, functools32 07:55:05 INFO - Running setup.py install for functools32 07:55:05 INFO - warning: no files found matching '*.txt' 07:55:05 INFO - no previously-included directories found matching 'build' 07:55:05 INFO - no previously-included directories found matching 'dist' 07:55:05 INFO - no previously-included directories found matching '.git*' 07:55:05 INFO - Successfully installed jsonschema functools32 07:55:05 INFO - Cleaning up... 07:55:05 INFO - Return code: 0 07:55:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c2909df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, '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': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', '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 07:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:55:05 INFO - Using env: {'DISPLAY': ':0', 07:55:05 INFO - 'HOME': '/home/cltbld', 07:55:05 INFO - 'LANG': 'en_US.UTF-8', 07:55:05 INFO - 'LANGUAGE': 'en_US:en', 07:55:05 INFO - 'LOGNAME': 'cltbld', 07:55:05 INFO - 'MAIL': '/var/mail/cltbld', 07:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:05 INFO - 'MOZ_NO_REMOTE': '1', 07:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:05 INFO - 'NO_EM_RESTART': '1', 07:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:05 INFO - 'PWD': '/builds/slave/test', 07:55:05 INFO - 'SHELL': '/bin/bash', 07:55:05 INFO - 'SHLVL': '1', 07:55:05 INFO - 'TERM': 'linux', 07:55:05 INFO - 'TMOUT': '86400', 07:55:05 INFO - 'USER': 'cltbld', 07:55:05 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:05 INFO - '_': '/tools/buildbot/bin/python'} 07:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:05 INFO - Downloading/unpacking flake8 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:55:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:55:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:55:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:08 INFO - no previously-included directories found matching 'docs/_build' 07:55:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:08 INFO - Running setup.py install for pep8 07:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:08 INFO - no previously-included directories found matching 'docs/_build' 07:55:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:55:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:08 INFO - Cleaning up... 07:55:08 INFO - Return code: 0 07:55:08 INFO - Running post-action listener: _resource_record_post_action 07:55:08 INFO - Running post-action listener: _start_resource_monitoring 07:55:08 INFO - Starting resource monitoring. 07:55:08 INFO - ##### 07:55:08 INFO - ##### Running install step. 07:55:08 INFO - ##### 07:55:08 INFO - Running pre-action listener: _resource_record_pre_action 07:55:08 INFO - Running main action method: install 07:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:08 INFO - Reading from file tmpfile_stdout 07:55:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:08 INFO - Reading from file tmpfile_stdout 07:55:08 INFO - Output received: 07:55:08 INFO - Usage: mozinstall [options] installer 07:55:08 INFO - Options: 07:55:08 INFO - -h, --help show this help message and exit 07:55:08 INFO - -d DEST, --destination=DEST 07:55:08 INFO - Directory to install application into. [default: 07:55:08 INFO - "/builds/slave/test"] 07:55:08 INFO - --app=APP Application being installed. [default: firefox] 07:55:08 INFO - mkdir: /builds/slave/test/build/application 07:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:55:24 INFO - Reading from file tmpfile_stdout 07:55:24 INFO - Output received: 07:55:24 INFO - /builds/slave/test/build/application/firefox/firefox 07:55:24 INFO - Running post-action listener: _resource_record_post_action 07:55:24 INFO - ##### 07:55:24 INFO - ##### Running run-tests step. 07:55:24 INFO - ##### 07:55:24 INFO - Running pre-action listener: _resource_record_pre_action 07:55:24 INFO - Running main action method: run_tests 07:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:24 INFO - Python 2.7.3 07:55:24 INFO - Return code: 0 07:55:24 INFO - grabbing minidump binary from tooltool 07:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:24 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 0x29e50b0>, '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 0x29e5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e6440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:24 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 07:55:24 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 07:55:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:24 INFO - Return code: 0 07:55:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:55:25 INFO - Return code: 0 07:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] in /builds/slave/test/build 07:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost 07:55:25 INFO - Using env: {'DISPLAY': ':0', 07:55:25 INFO - 'HOME': '/home/cltbld', 07:55:25 INFO - 'LANG': 'en_US.UTF-8', 07:55:25 INFO - 'LANGUAGE': 'en_US:en', 07:55:25 INFO - 'LOGNAME': 'cltbld', 07:55:25 INFO - 'MAIL': '/var/mail/cltbld', 07:55:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:25 INFO - 'MOZ_NO_REMOTE': '1', 07:55:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:25 INFO - 'NO_EM_RESTART': '1', 07:55:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:25 INFO - 'PWD': '/builds/slave/test', 07:55:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:25 INFO - 'SHELL': '/bin/bash', 07:55:25 INFO - 'SHLVL': '1', 07:55:25 INFO - 'TERM': 'linux', 07:55:25 INFO - 'TMOUT': '86400', 07:55:25 INFO - 'USER': 'cltbld', 07:55:25 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853', 07:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:25 INFO - '_': '/tools/buildbot/bin/python'} 07:55:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] with output_timeout 3600 07:55:25 INFO - mozversion INFO | application_buildid: 20151219070815 07:55:25 INFO - mozversion INFO | application_changeset: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 07:55:25 INFO - mozversion INFO | application_display_name: Nightly 07:55:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:25 INFO - mozversion INFO | application_name: Firefox 07:55:25 INFO - mozversion INFO | application_remotingname: firefox 07:55:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:55:25 INFO - mozversion INFO | application_vendor: Mozilla 07:55:25 INFO - mozversion INFO | application_version: 46.0a1 07:55:25 INFO - mozversion INFO | platform_buildid: 20151219070815 07:55:25 INFO - mozversion INFO | platform_changeset: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 07:55:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:55:25 INFO - mozversion INFO | platform_version: 46.0a1 07:55:25 INFO - 2015-12-19 07:55:25,748 DEBUG : using testdate: 1450540525 07:55:25 INFO - 2015-12-19 07:55:25,748 DEBUG : actual date: 1450540525 07:55:25 INFO - 2015-12-19 07:55:25,756 INFO : starting webserver on 'localhost:38606' 07:55:25 INFO - 2015-12-19 07:55:25,757 INFO : Starting test suite talos-linux64-ix-069 07:55:25 INFO - 2015-12-19 07:55:25,757 INFO : Starting test dromaeo_css 07:55:25 INFO - 2015-12-19 07:55:25,758 DEBUG : operating with platform_type : linux_ 07:55:25 INFO - 2015-12-19 07:55:25,758 INFO : Initialising browser for dromaeo_css test... 07:55:25 INFO - 2015-12-19 07:55:25,774 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbHtM5J/profile http://localhost:38606/getInfo.html 07:55:30 INFO - 2015-12-19 07:55:30,503 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:55:30 INFO - 2015-12-19 07:55:30,503 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:55:30 INFO - 2015-12-19 07:55:30,503 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:55:30 INFO - 2015-12-19 07:55:30,503 DEBUG : BROWSER_OUTPUT: __metrics 07:55:30 INFO - 2015-12-19 07:55:30,625 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:55:30 INFO - 2015-12-19 07:55:30,847 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:31 INFO - 2015-12-19 07:55:31,943 INFO : Browser initialized. 07:55:31 INFO - 2015-12-19 07:55:31,943 INFO : Running cycle 1/1 for dromaeo_css test... 07:55:31 INFO - 2015-12-19 07:55:31,943 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbHtM5J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:55:43 INFO - 2015-12-19 07:55:43,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 150323200 07:55:43 INFO - 2015-12-19 07:55:43,893 DEBUG : BROWSER_OUTPUT: 07:56:35 INFO - 2015-12-19 07:56:35,280 DEBUG : BROWSER_OUTPUT: 1450540595277 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] 07:58:47 INFO - 2015-12-19 07:58:47,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38606/tests/dromaeo/cssquery-ext.html) 07:58:48 INFO - 2015-12-19 07:58:48,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 235020288 07:58:48 INFO - 2015-12-19 07:58:48,556 DEBUG : BROWSER_OUTPUT: 08:01:50 INFO - 2015-12-19 08:01:50,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-ext.html (next: http://localhost:38606/tests/dromaeo/cssquery-jquery.html) 08:01:51 INFO - 2015-12-19 08:01:51,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 232275968 08:01:51 INFO - 2015-12-19 08:01:51,570 DEBUG : BROWSER_OUTPUT: 08:04:53 INFO - 2015-12-19 08:04:53,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38606/tests/dromaeo/cssquery-mootools.html) 08:04:54 INFO - 2015-12-19 08:04:54,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 231927808 08:04:54 INFO - 2015-12-19 08:04:54,217 DEBUG : BROWSER_OUTPUT: 08:07:56 INFO - 2015-12-19 08:07:56,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38606/tests/dromaeo/cssquery-prototype.html) 08:07:56 INFO - 2015-12-19 08:07:56,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 217092096 08:07:56 INFO - 2015-12-19 08:07:56,758 DEBUG : BROWSER_OUTPUT: 08:10:59 INFO - 2015-12-19 08:10:59,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38606/tests/dromaeo/cssquery-yui.html) 08:11:00 INFO - 2015-12-19 08:11:00,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 209563648 08:11:00 INFO - 2015-12-19 08:11:00,084 DEBUG : BROWSER_OUTPUT: 08:14:02 INFO - 2015-12-19 08:14:02,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-yui.html (next: http://localhost:38606/tests/dromaeo/cssquery-dojo.html) 08:14:03 INFO - 2015-12-19 08:14:03,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 263008256 08:14:03 INFO - 2015-12-19 08:14:03,018 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:14:03 INFO - 2015-12-19 08:14:03,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:14:03 INFO - 2015-12-19 08:14:03,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:14:03 INFO - 2015-12-19 08:14:03,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:14:03 INFO - 2015-12-19 08:14:03,022 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2620.3580122869894;2701.257154282573;2702.405470796425;2714.9864250678743;2721.3196700824788;4466.062126953336;4599.517050709677;4670.50959649237;4707.152712511746;4714.90570188596;4599.724016559009;4612.769361531919;4696.8590942271785;4704.529547045294;4713.670043096985;4288.120935208275;4299.763513006791;4308.741475511463;4310.56894310568;4338.826446942135;4145.854895078673;4355.932796464871;4365.585269399402;4402.735835849843;4436.334549817521;4168.478940132483;4230.111676547928;4307.547707490731;4340.13197360526;4352.173087113439;4261.74429534229;4335.978320108379;4344.956550434518;4372.519022907478;4383.693141480097;4089.795510224477;4304.5480224576595;4317.287647538184;4337.934930976038;4382.035952090535;4577.359169716243;4585.037142200142;4643.419572553431;4766.38037055184;4772.427308722976;4985.90028199434;4999.825006124768;5003.374578177728;5004.624653151028;5051.595872330205;5025.1959686450355;5031.4465408805;5037.0429618372755;5037.143685573425;5049.772760225798;4479.9552004479865;4579.290210017452;4583.312503124492;4650;4768.737719425465;5188.247704082887;5188.792448302102;5197.246399272084;5204.1673332266655;5252.9737351313;4978.6763860348965;4992.850214493571;5000.199968005175;5007.39911210657;5021.84934451967;4789.712617242976;4880.951190488121;4895;4978.800847966041;5061.544460998528;4984.77568509418;5014.799408023711;5017.297578339036;5017.422996355393;5061.342025536656;4984.22744474607;4992.375953005874;4993.026359859865;4996.07572599063;5042.319286896222;4058.228936502055;4124;4162.188373267244;4165.770882601486;4167.416561681367;3611.7291203159866;3647.6717095461536;3649.3431182387426;3650.7079433645245;3652.470391793175;4241.660667146621;4301.139772045541;4301.827926882952;4327.480702315742;4338.60952514269;5017.046761115376;5052.545270925634;5059.06407314648;5060.7216603086445;5109.6678715883345;4137.193247316744;4232.32282834745;4337.457817772778;4338.240807858612;4340.435743353344;4398.582134697199;4445.488768791631;4482.013956929471;4486.977565112154;4519.977400112978;4757.238841785298;4760.381150450419;4763.071201115749;4764.14245435818;4795.064962332382;4746.359241502491;4917.557419832232;5033.597312214941;5038.47096054909;5073.036123136592;4675.976620116878;4709.693869898582;4758.714477131383;4774.116788394158;4822.035592881508;4924.753762311799;4933.753312334297;4946.332245146859;4971.229459433794;4979.402471703419;4811.927821082617;4911.115999120193;5022.874428139179;5032.119379108714;5062;4813.807447702053;4819.180739274261;4855.902881942412;4883.853484395474;4915.557599816034;4770.189067858541;4819.373481447389;4829.372181616508;4830.661853670209;4872.293517439881;4618.122556714214;4731.195696731633;4741.099191153669;4744.501827308083;4787.664863459524;4833.854984350475;4861.635377346643;4907.386576677915;4924.162892308244;4965.702057876539;4742.644301677319;4755.262934245197;4757.215059515142;4803.3995750531185;4819.783109759999 08:14:03 INFO - 2015-12-19 08:14:03,026 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.1507003863856;538.3244028743926;548.9871187658771;565.3329071695399;568.5678884048123;26628.600570991428;32507.51238731418;32698.8555400561;32752.836235818846;32850.67149328506;38785.612143878556;39939;39996.40005399921;40005;40021.39967900484;6894.31056894309;7018.4385249180195;7848.8037799055055;8035.919640803576;8040.276375126237;10021.799564008716;10293.742656433611;10308;10310.845337319908;10316.638917637883;9993.550290236957;10030.648927287546;10098.697039088802;10101;10112.544935477885;7249.456290778213;7431.777046688608;7441.069866266716;9793.461359625218;10185.38887666735;9822.214222862154;9952.950235248778;9967.302288839785;9977.700668979942;9988.850167247498;37351.813240933894;37810.81094594537;37821;37828.243435131146;37854.62145378539;2946.528555431142;3006.834624095674;3008.443437963962;3439.7420193485586;3560.8041557714314;27715.307117322027;27977;28261.57607635887;28349.291267718265;28579.714202857915;3346.196912740949;3364.2598628301735;3446.9482957755654;3542.7697199682198;3561.857525698969;213223;213306;213574;214390;214616;52547.21179182315;52794.20808687873;53111;53157.2026419604;53161.46838531565;56078;56258.15612765812;56306.71846640741;56431.71784141053;56459.43540564624;13700.45198192061;13754.518591849237;14014.299285035708;14056.71886562263;14084;11321.377324247082;11393.715157121138;11399.886001140048;11401;11403.657890263305;17492.20124780029;17838;17873.463796086136;17883.910580447013;17957.820421795877;7093.89359159613;7292.34368906801;7325.601142845658;7339.604966814881;7379.963100184465;904.7828521154876;916.1067958740308;956.4309236004566;1009.8992098612548;1014.5992333028413;28424.28939276493;29681.25796855096;29681.406371872443;30075.548866767014;30228.395432091234;877.912208779117;963.8939716631165;973.1873885305707;1010.9443980581138;1055.3298655353906;12368.938155309166;12639.241645501299;14159.292035398395;15091.396344146331;15303.46437874669;248452;278018;282678;282806;283632;37227.62772372241;48401.27398089031;49179.50820491821;49203.50796492061;49469.50530494649;1210.4189988805422;1219.4514956945861;1222.926624402521;1227.1287385955893;1229.655696405008;23234.3029709109;25038;25642.48715025652;26478.338041549116;26936.32659183536;36069.45895811617;36372.818135909154;36379.27241455209;36422;36429;167676;168349.15825420796;168646;168687;169038;25654;26059.609105863048;26063.869680651474;26079.60880586755;28483.145505634864;33765.49351759676;33923;34080;34464.138396540286;35944.460833087;31763;32120.839395802872;32142.517862232555;32581.837090814395;32595.348093037534;31671.629810574388;32021;32276.83861580771;32318.67681323251;32415.35169296648;32513.512297316032;32854.34291314208;33077.17307067342;33503.66496335103;33635.83182084172;26480;29403.41193176167;29604.259893502836;29747.702522974494;29755.10734677963;22950.42623934415;22953.77046229583;23048.654270185627;23301.76698232996;23338.53322933566 08:14:03 INFO - 2015-12-19 08:14:03,027 DEBUG : BROWSER_OUTPUT: |2;jquery.html;318.9027346659268;320.37207074134693;325.4873574120759;325.7849819119382;333.74635277189327;14866.925665371671;15410.075395476279;16042.51872443827;16920.746188807178;16940.152992350362;14879.851201487982;15355.769663455028;15726.84273157268;15836.84163158368;15856.762148567752;4800.207965685658;4927.063857866994;4929.876753081184;4931.827386041471;4932.926006109911;4788;4858.951410485903;4897.975510122445;4941.6540842140885;4946.208606622941;3629.401148810443;3749.9062523436996;4919.975400122994;4925.901481970359;5660.60375773696;5863.149843272744;5889.528837692974;5910.556708246877;5917.704114794265;5929.436703513159;5021.899562008776;5032.547070763649;5033;5034.043531728997;5129.0767661820855;14116.647083822883;14767.187804670739;18227.54431139219;18936.71594926077;19783.20867165326;1865.347128505026;1896.0140726822112;1933.9129739161772;1999.2602736987262;2009.2967461388398;8635.784105397352;8898.065703101145;12608.243505389706;12625.936870315682;13077.542286019943;1725.7411388291732;1731.6536692661518;1732.7660765796581;1749.588846621043;1768.602064535482;47277.527224728;49282.7535862322;50976.64745201737;58707.70646146742;59179.1123133149;9717.368371055858;9722.465264410384;9788.608455661837;9793.363431376938;9832.410055396698;12466.81299780504;12476.750464990831;12477.376131193403;12482.75034499323;12487.687807804878;7106;7220.855582888313;7273.199948005715;7304.8173795654475;7367.742129025459;6948.93051069493;6955.652217389212;6981.441484681213;6996.720131194696;7048.118985126859;4103.794810259535;4115.1975364803575;4116.567760385176;4127.711060225815;4138.937915931264;1691.560194349478;1703.1143805221216;1703.3527259641257;1724.4912750738563;1744.276125407967;792.3740245206337;798.2616080125861;842.5829214538843;890.643742502991;927.1053433436766;14852.777208341884;15099.245037748069;15647;15998.840011599736;16084.839151608568;837.9078301386843;849.4945507423073;874.9343799214957;926.2034650200957;955.4506158958627;7831.2560306770765;8846.336524760669;9219.677311294072;9429.198518125899;9548.273421530628;520292;523792;525689;529404.4119117596;532761;73792.26207737855;74156.25843741602;74759.75720728387;75220.24779752133;76261.23738762652;1051.5373235776235;1063.3938654966594;1068.278911734576;1072.485207100596;1091.776185881908;14792.482263120739;14872.479463219168;14965.401383944956;15043.548693539211;15125.697486050438;33668.83165584156;33865.322693546485;33889.66110338865;33910.15224619404;34179;44199.55800442083;44213.557864420945;44570.331445029;46214;47500.28749568828;8395.370347224105;8827.382083254111;8889.511076890833;8894.688685895962;8900.243479304332;10272.22958278147;10351.792964140524;15695.843041569895;16372.508824735278;16385.50843474698;12681.556145534862;12783.872161278268;12801.48794048265;13537.526186583422;14038.438462461387;13189;13333.733325333633;13483.932580337429;13669.589912302647;13856.930715346762;13742.587722368346;13880.722385552433;14107;14249;14307.070040447337;8714;8796.516191609522;8884;9032.36773425854;9032.412893161923;9373.484458354857;9428.10433008863;9465.621375144918;12474.5010199591;13756.518521851687 08:14:03 INFO - 2015-12-19 08:14:03,030 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1412.7810189420643;1647.1681800690649;1698.3291599818072;1712.7944646642402;1721.1308289313886;5775.104858746896;6933.722651093956;7277.5269607475475;7292.525985810918;7295.89056164158;7273.418126549876;7424.146223184335;7431.665575049122;7431.814204644887;7436.405087592993;1777.83110604493;1815.6550255451489;2050.169681279084;2072.8963551822426;2081.885496297703;2136.935891923245;2141.935741927745;2143.528423746773;2143.7534683511362;2143.882086485243;2048.795120487947;2053.425040988518;2071.3475255294534;2075.0662202009157;2084.4893001214723;1940.40817550647;1977.5748214133957;1981.5640559077124;1998.2206939293687;2000.449876284019;2101.6006958677954;2114.2494414482944;2125.415510734545;2126.447123747821;2133.7012818205462;7294.452916031266;7352.77941661751;7367.152777430557;7375.520591161558;7382.151052628909;4301.698881078326;4389.341598760179;4390.0122472443445;4398.34024896265;4402.51572327047;2766.958495622567;2779.277387879146;2825.519661657523;2849.7435230829324;2858.814177078483;873.9300855931574;878.6309749905055;892.848215803315;893.7765558610347;899.3884158772098;9965.75085622858;10030.899691003142;10031.799364012752;10042.799144017079;10092.697219083439;3893.980530097331;3900.570937196906;3941.842326306973;3946.5264168299987;3950.58518855516;8636.568171591522;8647.87577614906;8658.610362533702;8661.047284798668;8670.219680228809;4373.322135069069;4380.912381752347;4401.295792673157;4408.162449134654;4408.58118478744;3952.8616498422416;3963.009247688078;3998.9600103998587;4002.9199416011515;4005.599440055971;3023.047739961905;3094.334718035633;3347.41420251455;3429.9314013720086;3473.548438703003;1071.3518321415588;1072.2976450424985;1074.1621535202555;1080.1628737728324;1095.2771171027084;923.4643906534194;930.0745757970727;966.4636126949611;1172.783035138502;1183.0771997841698;6859.176898772179;6872;6927.411170050602;6955.721771129098;6957.373836354753;972.5817898303656;981.2052237687353;1031.582209205273;1042.1923009667569;1049.1449468683;5340.759665815048;5423.945760542423;5469.234307196995;5487.149491828773;5499.890002199933;8787.692430764893;8993.910060899307;9097.363184577149;9131.497767622712;9135.451872887648;8777.868331975025;8857.689980850768;8969.103089691109;9027.593758280893;9039.864402033974;6954.79135625932;6958.47811414146;6960.234374218832;7014.088168538057;7040.718371265194;6564.901526477202;6612.173478315211;6672.366125218096;6701.731930722716;6735.158105236846;7159.17669467997;7689.50018248812;7918.802029949067;7993.840123197388;8019.318357939641;7712.9614351927885;7766.805829854073;7850.293473587404;7997.520148791091;8186.508809471451;6903.585784852925;6980.860382792214;6994.965025174842;7000.089988301692;7015.508914376149;5940.702964851826;5974.850628734316;6089.33017368098;6837.487188460786;7081.82295442618;6194.5044396449075;6530.281669016309;6770.6614669265355;6858.862822743617;6897.241303456515;6604.0754294399785;6627.6354800484505;6636.2368327642935;6710.865782684416;6783.525153239226;6598.076269322395;6603.867922641616;6619.536632435684;6629.6353700545005;6634.436072933855;6195.721192546436;6216.378362163748;6218.657973811484;6222;6229.781957631461;6080.300765412034;6222.657753823583;6223.097650840512;6243.188385510036;6247.9062814056915 08:14:03 INFO - 2015-12-19 08:14:03,032 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.9764818814495;300.3527398456326;301.96829332920043;307.1063206070336;309.35190775325685;5201.42682531368;5228.189630607258;5284.969430960964;5302.575793936486;5309.787608495665;5220.582353411727;5228.424873263938;5236.92144617831;5241.606879484035;5252.080885844981;3882.941755873664;4124.546299907008;4134.111166099288;4139.565345638703;4141.834326626931;3998.300297447935;4008.1783234437016;4137.937930931039;4144.357624568197;4151.2112698587325;4103.302438585448;4103.38449232616;4105.486814148231;4113.341865301552;4116.094459218982;3879.573246942834;3963.623455771697;3969;4109.3425051991535;4110.1163249901265;3628.310620982005;3629.038304849217;3651.488791569156;3653.1962968146963;3654.5979942206336;5049.949500505021;5065.1642478990925;5067.6452648314635;5072.695638261679;5074.974625126888;4730.455997560291;4733.100710864925;4734.384530011076;4738.3603213566075;4741.834035808764;5321.148616221386;5511.724413779295;5525.254090697745;5528.502434780889;5533.667979921177;3859.186182494251;3860.5946375630715;3860.976841137101;3860.9806950965344;3861.8455261789495;5718.142278658193;5797.942020579824;5803.100519419497;5803.709814509258;5807.448292412214;3965.643092121723;3975.1254723960683;3976.741511801724;3976.980115099406;3979.343408337592;3938.310795610814;4034.1528279061727;4034.5158580969883;4034.536028356718;4038.697097717683;4627;4632.3977882875015;4636.095961287584;4639.072185562901;4639.466461356919;5508.091164957737;5516;5516.117421212667;5518.972405137949;5519.641223320471;1393.7003544238037;1419.2265215457394;1421.8293804743496;1422.2462095089413;1422.2746399336413;929.4980710416435;931.5761328595473;944.4333399959969;975.3903810118676;976.4873441443157;4827.227643577011;4833.10587541299;4838.540338667821;4839.975800120977;4842.080004799077;5708.857278568069;5720.08478643415;5720.971395142998;5722.37053924068;5725.3988331225455;4806.110869489155;4821.276808478756;4825.5898248649255;4829.6860704054125;4832.710037397767;2885.6183218297724;2985.462616728966;3050.694930506976;3077.2153100959113;3078.4766589679807;4805.6155507559315;5482.958237934779;5483;5488.780448782004;5498;5919.3192782829665;5927.8221653350465;5928.081147422156;5941.554383421174;5943.613665111754;5475.589330800126;5475.835724928259;5483.424240454695;5489.984352894728;5490.286262785812;5558.221848941233;5746.971265143815;5773.364929857628;5776.046952252831;5783.392743761844;5635.549156067586;5638.661680299195;5640.266765320646;5640.689762063126;5643.887122257614;5488.780448782004;5492.0663487206475;5492.972535137458;5496.395396506461;5498.780048798003;3924.293627147141;3967.6032396761248;3968.543617484026;3969.345058065502;3971.9205615886945;5509.917351239815;5655.179998900218;5755.884882302246;5756.222909907109;5762.740676669644;5393.9730301348245;5459.808906688247;5464.1257398816;5468.48049435303;5530.087535556749;5382.703951282717;5510.311211098613;5549.417311182429;5549.5837812163445;5553.805616803393;5335.546478549367;5395.757190926339;5437.5378092860965;5442.5645948323245;5445.591580631548;5550.417206193453;5592.077307244259;5593.804216852391;5596.384397716167;5598.86002849932;5446.400895901368;5456.945430545644;5458.754356054066;5461.9180712290145;5466.863328416822 08:14:03 INFO - 2015-12-19 08:14:03,033 DEBUG : BROWSER_OUTPUT: |5;yui.html;652.5562617420154;656.3174298729322;695.2421860172411;774.3456779021725;796.3191471292041;10748.086412654924;11007.174461915349;11010.119190464764;11056.502457389417;11058.447077646115;10087.495625218746;10547.945205479447;10695.037446629802;11098.500567474463;11128.944355278232;782.9373650107992;804.3042768005662;804.3082948664144;804.6057431858405;804.9195080491962;773.9922600773976;783.5416281475316;787.7715462515863;788.1094363369384;788.6056971514242;810.2464707821723;827.1273806134526;829.7344849648115;829.7676650537859;830.485099238473;819.5451524403924;820.2945466898523;820.5240960243045;820.7209548753423;820.7742870710542;608.8995315772892;610.2432983100967;610.7160170520684;610.8137018209444;610.9053096770008;9726.9513652432;9739.951300243525;9742.07450292221;9844.556994935245;9850.60597576096;8651.913480865236;8814.779630509225;9092.181703646638;9437.528123593793;9922.603095876157;8517.105703901125;8585.871211931826;8622.913770862273;8624.741257762276;8687.391882568223;3043.284828065425;3121.719045285935;3179.3959147761852;3182.965536200721;3185.904422867318;34752.30495390078;35473.82263088668;38107.23785524274;38137.23725525474;38432.61567384318;9019.233365163904;9176.17414432691;9225.953870230605;9376.484293363794;9440.90559094414;16305.918470407572;16322.183890805649;16345.591360215853;16351.26419311134;16363.754543681855;5330.016434633552;5636.205812804992;6367.586106903036;6433.388828061326;6568.244651865001;3701.2597480504005;3708.721845861571;3724.478572999782;3737.3459644562095;3845.942310865339;2654.7477989590957;2680.209338245222;2682.7049024607277;2683.0475181310744;2688.5160671079;452.8211356514224;464.80478199156437;468.11526215452824;473.4862673998681;474.1749356120326;531.6119232959884;547.1764993684479;555.686037388882;565.4938829747435;604.3291945940003;7114.750983715545;7160.57036577807;7245.166805817293;7378.1121615601005;7494.587797671181;572.9799457019068;579.4292621767555;579.5421616922669;580.3963877567367;588.1325045557768;3388.186835159593;3401.795892246473;3442.7417943654327;3489.668481494254;3561.5370001900105;47529.762351188714;48181.759091204316;48202.517974819806;48316;48452.757736211795;42984.785076075044;43019.92450188708;43415.131697365876;44057;44183.33724994128;36703.449448258296;37000;42820.35769463461;44466.3330050043;45238.77380613076;7824.92175078242;7842.725504607311;7899.052113746157;8063.637136328762;8244.093149753642;26231.213063608124;30381.088567343017;30923.84538077385;31016.379672406878;31104.22239444032;32612.34775304528;36169.63830361768;36241;36773;37028.00121983606;10019.448930308903;10231.641892534024;10425.687229383131;10472;10961.83557246626;11099.445027748741;11294;11425.37160456183;11511.251768635011;12011.159218854946;10266.43534605574;10499.632512862014;10615.575376984834;11018.669439916815;11070.501827417947;10338.379697218192;10482.318649287772;10727.40999245049;10853.131749459866;10855;10324.296491079189;10775.6228532001;10787.568497260021;10796;10842.620508282173;8619.1811777881;8750.124987501198;8762.386632935633;8893;8904.421212621159;9004.954975225082;9032;9119.726408207764;9219;9255.35212535116 08:14:03 INFO - 2015-12-19 08:14:03,033 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:14:03 INFO - 2015-12-19 08:14:03,033 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,860 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1450541643019__endTimestamp 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:14:03 INFO - 2015-12-19 08:14:03,034 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,035 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4617.62 Median:4757.24 stddev:486.00 (10.2%) stddev-sans-first:461.55 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: Values: 2620.4 2701.3 2702.4 2715.0 2721.3 4466.1 4599.5 4670.5 4707.2 4714.9 4599.7 4612.8 4696.9 4704.5 4713.7 4288.1 4299.8 4308.7 4310.6 4338.8 4145.9 4355.9 4365.6 4402.7 4436.3 4168.5 4230.1 4307.5 4340.1 4352.2 4261.7 4336.0 4345.0 4372.5 4383.7 4089.8 4304.5 4317.3 4337.9 4382.0 4577.4 4585.0 4643.4 4766.4 4772.4 4985.9 4999.8 5003.4 5004.6 5051.6 5025.2 5031.4 5037.0 5037.1 5049.8 4480.0 4579.3 4583.3 4650.0 4768.7 5188.2 5188.8 5197.2 5204.2 5253.0 4978.7 4992.9 5000.2 5007.4 5021.8 4789.7 4881.0 4895.0 4978.8 5061.5 4984.8 5014.8 5017.3 5017.4 5061.3 4984.2 4992.4 4993.0 4996.1 5042.3 4058.2 4124.0 4162.2 4165.8 4167.4 3611.7 3647.7 3649.3 3650.7 3652.5 4241.7 4301.1 4301.8 4327.5 4338.6 5017.0 5052.5 5059.1 5060.7 5109.7 4137.2 4232.3 4337.5 4338.2 4340.4 4398.6 4445.5 4482.0 4487.0 4520.0 4757.2 4760.4 4763.1 4764.1 4795.1 4746.4 4917.6 5033.6 5038.5 5073.0 4676.0 4709.7 4758.7 4774.1 4822.0 4924.8 4933.8 4946.3 4971.2 4979.4 4811.9 4911.1 5022.9 5032.1 5062.0 4813.8 4819.2 4855.9 4883.9 4915.6 4770.2 4819.4 4829.4 4830.7 4872.3 4618.1 4731.2 4741.1 4744.5 4787.7 4833.9 4861.6 4907.4 4924.2 4965.7 4742.6 4755.3 4757.2 4803.4 4819.8 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38149.31 Median:32070.92 stddev:58182.25 (181.4%) stddev-sans-first:58276.91 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: Values: 534.2 538.3 549.0 565.3 568.6 26628.6 32507.5 32698.9 32752.8 32850.7 38785.6 39939.0 39996.4 40005.0 40021.4 6894.3 7018.4 7848.8 8035.9 8040.3 10021.8 10293.7 10308.0 10310.8 10316.6 9993.6 10030.6 10098.7 10101.0 10112.5 7249.5 7431.8 7441.1 9793.5 10185.4 9822.2 9953.0 9967.3 9977.7 9988.9 37351.8 37810.8 37821.0 37828.2 37854.6 2946.5 3006.8 3008.4 3439.7 3560.8 27715.3 27977.0 28261.6 28349.3 28579.7 3346.2 3364.3 3446.9 3542.8 3561.9 213223.0 213306.0 213574.0 214390.0 214616.0 52547.2 52794.2 53111.0 53157.2 53161.5 56078.0 56258.2 56306.7 56431.7 56459.4 13700.5 13754.5 14014.3 14056.7 14084.0 11321.4 11393.7 11399.9 11401.0 11403.7 17492.2 17838.0 17873.5 17883.9 17957.8 7093.9 7292.3 7325.6 7339.6 7380.0 904.8 916.1 956.4 1009.9 1014.6 28424.3 29681.3 29681.4 30075.5 30228.4 877.9 963.9 973.2 1010.9 1055.3 12368.9 12639.2 14159.3 15091.4 15303.5 248452.0 278018.0 282678.0 282806.0 283632.0 37227.6 48401.3 49179.5 49203.5 49469.5 1210.4 1219.5 1222.9 1227.1 1229.7 23234.3 25038.0 25642.5 26478.3 26936.3 36069.5 36372.8 36379.3 36422.0 36429.0 167676.0 168349.2 168646.0 168687.0 169038.0 25654.0 26059.6 26063.9 26079.6 28483.1 33765.5 33923.0 34080.0 34464.1 35944.5 31763.0 32120.8 32142.5 32581.8 32595.3 31671.6 32021.0 32276.8 32318.7 32415.4 32513.5 32854.3 33077.2 33503.7 33635.8 26480.0 29403.4 29604.3 29747.7 29755.1 22950.4 22953.8 23048.7 23301.8 23338.5 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27514.09 Median:4133.32 stddev:85957.94 (2079.6%) stddev-sans-first:86174.82 08:14:03 INFO - 2015-12-19 08:14:03,036 DEBUG : BROWSER_OUTPUT: Values: 318.9 320.4 325.5 325.8 333.7 14866.9 15410.1 16042.5 16920.7 16940.2 14879.9 15355.8 15726.8 15836.8 15856.8 4800.2 4927.1 4929.9 4931.8 4932.9 4788.0 4859.0 4898.0 4941.7 4946.2 3629.4 3749.9 4920.0 4925.9 5660.6 5863.1 5889.5 5910.6 5917.7 5929.4 5021.9 5032.5 5033.0 5034.0 5129.1 14116.6 14767.2 18227.5 18936.7 19783.2 1865.3 1896.0 1933.9 1999.3 2009.3 8635.8 8898.1 12608.2 12625.9 13077.5 1725.7 1731.7 1732.8 1749.6 1768.6 47277.5 49282.8 50976.6 58707.7 59179.1 9717.4 9722.5 9788.6 9793.4 9832.4 12466.8 12476.8 12477.4 12482.8 12487.7 7106.0 7220.9 7273.2 7304.8 7367.7 6948.9 6955.7 6981.4 6996.7 7048.1 4103.8 4115.2 4116.6 4127.7 4138.9 1691.6 1703.1 1703.4 1724.5 1744.3 792.4 798.3 842.6 890.6 927.1 14852.8 15099.2 15647.0 15998.8 16084.8 837.9 849.5 874.9 926.2 955.5 7831.3 8846.3 9219.7 9429.2 9548.3 520292.0 523792.0 525689.0 529404.4 532761.0 73792.3 74156.3 74759.8 75220.2 76261.2 1051.5 1063.4 1068.3 1072.5 1091.8 14792.5 14872.5 14965.4 15043.5 15125.7 33668.8 33865.3 33889.7 33910.2 34179.0 44199.6 44213.6 44570.3 46214.0 47500.3 8395.4 8827.4 8889.5 8894.7 8900.2 10272.2 10351.8 15695.8 16372.5 16385.5 12681.6 12783.9 12801.5 13537.5 14038.4 13189.0 13333.7 13483.9 13669.6 13856.9 13742.6 13880.7 14107.0 14249.0 14307.1 8714.0 8796.5 8884.0 9032.4 9032.4 9373.5 9428.1 9465.6 12474.5 13756.5 08:14:03 INFO - 2015-12-19 08:14:03,037 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,037 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5122.21 Median:6226.44 stddev:2687.23 (43.2%) stddev-sans-first:2680.31 08:14:03 INFO - 2015-12-19 08:14:03,038 DEBUG : BROWSER_OUTPUT: Values: 1412.8 1647.2 1698.3 1712.8 1721.1 5775.1 6933.7 7277.5 7292.5 7295.9 7273.4 7424.1 7431.7 7431.8 7436.4 1777.8 1815.7 2050.2 2072.9 2081.9 2136.9 2141.9 2143.5 2143.8 2143.9 2048.8 2053.4 2071.3 2075.1 2084.5 1940.4 1977.6 1981.6 1998.2 2000.4 2101.6 2114.2 2125.4 2126.4 2133.7 7294.5 7352.8 7367.2 7375.5 7382.2 4301.7 4389.3 4390.0 4398.3 4402.5 2767.0 2779.3 2825.5 2849.7 2858.8 873.9 878.6 892.8 893.8 899.4 9965.8 10030.9 10031.8 10042.8 10092.7 3894.0 3900.6 3941.8 3946.5 3950.6 8636.6 8647.9 8658.6 8661.0 8670.2 4373.3 4380.9 4401.3 4408.2 4408.6 3952.9 3963.0 3999.0 4002.9 4005.6 3023.0 3094.3 3347.4 3429.9 3473.5 1071.4 1072.3 1074.2 1080.2 1095.3 923.5 930.1 966.5 1172.8 1183.1 6859.2 6872.0 6927.4 6955.7 6957.4 972.6 981.2 1031.6 1042.2 1049.1 5340.8 5423.9 5469.2 5487.1 5499.9 8787.7 8993.9 9097.4 9131.5 9135.5 8777.9 8857.7 8969.1 9027.6 9039.9 6954.8 6958.5 6960.2 7014.1 7040.7 6564.9 6612.2 6672.4 6701.7 6735.2 7159.2 7689.5 7918.8 7993.8 8019.3 7713.0 7766.8 7850.3 7997.5 8186.5 6903.6 6980.9 6995.0 7000.1 7015.5 5940.7 5974.9 6089.3 6837.5 7081.8 6194.5 6530.3 6770.7 6858.9 6897.2 6604.1 6627.6 6636.2 6710.9 6783.5 6598.1 6603.9 6619.5 6629.6 6634.4 6195.7 6216.4 6218.7 6222.0 6229.8 6080.3 6222.7 6223.1 6243.2 6247.9 08:14:03 INFO - 2015-12-19 08:14:03,038 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,039 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4590.96 Median:5239.26 stddev:1349.07 (25.7%) stddev-sans-first:1313.74 08:14:03 INFO - 2015-12-19 08:14:03,039 DEBUG : BROWSER_OUTPUT: Values: 294.0 300.4 302.0 307.1 309.4 5201.4 5228.2 5285.0 5302.6 5309.8 5220.6 5228.4 5236.9 5241.6 5252.1 3882.9 4124.5 4134.1 4139.6 4141.8 3998.3 4008.2 4137.9 4144.4 4151.2 4103.3 4103.4 4105.5 4113.3 4116.1 3879.6 3963.6 3969.0 4109.3 4110.1 3628.3 3629.0 3651.5 3653.2 3654.6 5049.9 5065.2 5067.6 5072.7 5075.0 4730.5 4733.1 4734.4 4738.4 4741.8 5321.1 5511.7 5525.3 5528.5 5533.7 3859.2 3860.6 3861.0 3861.0 3861.8 5718.1 5797.9 5803.1 5803.7 5807.4 3965.6 3975.1 3976.7 3977.0 3979.3 3938.3 4034.2 4034.5 4034.5 4038.7 4627.0 4632.4 4636.1 4639.1 4639.5 5508.1 5516.0 5516.1 5519.0 5519.6 1393.7 1419.2 1421.8 1422.2 1422.3 929.5 931.6 944.4 975.4 976.5 4827.2 4833.1 4838.5 4840.0 4842.1 5708.9 5720.1 5721.0 5722.4 5725.4 4806.1 4821.3 4825.6 4829.7 4832.7 2885.6 2985.5 3050.7 3077.2 3078.5 4805.6 5483.0 5483.0 5488.8 5498.0 5919.3 5927.8 5928.1 5941.6 5943.6 5475.6 5475.8 5483.4 5490.0 5490.3 5558.2 5747.0 5773.4 5776.0 5783.4 5635.5 5638.7 5640.3 5640.7 5643.9 5488.8 5492.1 5493.0 5496.4 5498.8 3924.3 3967.6 3968.5 3969.3 3971.9 5509.9 5655.2 5755.9 5756.2 5762.7 5394.0 5459.8 5464.1 5468.5 5530.1 5382.7 5510.3 5549.4 5549.6 5553.8 5335.5 5395.8 5437.5 5442.6 5445.6 5550.4 5592.1 5593.8 5596.4 5598.9 5446.4 5456.9 5458.8 5461.9 5466.9 08:14:03 INFO - 2015-12-19 08:14:03,039 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,039 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11744.29 Median:47855.76 stddev:13265.11 (27.7%) stddev-sans-first:13276.17 08:14:03 INFO - 2015-12-19 08:14:03,040 DEBUG : BROWSER_OUTPUT: Values: 652.6 656.3 695.2 774.3 796.3 10748.1 11007.2 11010.1 11056.5 11058.4 10087.5 10547.9 10695.0 11098.5 11128.9 782.9 804.3 804.3 804.6 804.9 774.0 783.5 787.8 788.1 788.6 810.2 827.1 829.7 829.8 830.5 819.5 820.3 820.5 820.7 820.8 608.9 610.2 610.7 610.8 610.9 9727.0 9740.0 9742.1 9844.6 9850.6 8651.9 8814.8 9092.2 9437.5 9922.6 8517.1 8585.9 8622.9 8624.7 8687.4 3043.3 3121.7 3179.4 3183.0 3185.9 34752.3 35473.8 38107.2 38137.2 38432.6 9019.2 9176.2 9226.0 9376.5 9440.9 16305.9 16322.2 16345.6 16351.3 16363.8 5330.0 5636.2 6367.6 6433.4 6568.2 3701.3 3708.7 3724.5 3737.3 3845.9 2654.7 2680.2 2682.7 2683.0 2688.5 452.8 464.8 468.1 473.5 474.2 531.6 547.2 555.7 565.5 604.3 7114.8 7160.6 7245.2 7378.1 7494.6 573.0 579.4 579.5 580.4 588.1 3388.2 3401.8 3442.7 3489.7 3561.5 47529.8 48181.8 48202.5 48316.0 48452.8 42984.8 43019.9 43415.1 44057.0 44183.3 36703.4 37000.0 42820.4 44466.3 45238.8 7824.9 7842.7 7899.1 8063.6 8244.1 26231.2 30381.1 30923.8 31016.4 31104.2 32612.3 36169.6 36241.0 36773.0 37028.0 10019.4 10231.6 10425.7 10472.0 10961.8 11099.4 11294.0 11425.4 11511.3 12011.2 10266.4 10499.6 10615.6 11018.7 11070.5 10338.4 10482.3 10727.4 10853.1 10855.0 10324.3 10775.6 10787.6 10796.0 10842.6 8619.2 8750.1 8762.4 8893.0 8904.4 9005.0 9032.0 9119.7 9219.0 9255.4 08:14:03 INFO - 2015-12-19 08:14:03,040 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:14:03 INFO - 2015-12-19 08:14:03,041 DEBUG : BROWSER_OUTPUT: 08:14:03 INFO - 2015-12-19 08:14:03,766 INFO : Browser exited with error code: 0 08:14:03 INFO - 2015-12-19 08:14:03,782 INFO : Completed test dromaeo_css (00:18:38) 08:14:03 INFO - 2015-12-19 08:14:03,782 INFO : Starting test kraken 08:14:03 INFO - 2015-12-19 08:14:03,782 DEBUG : operating with platform_type : linux_ 08:14:03 INFO - 2015-12-19 08:14:03,782 INFO : Initialising browser for kraken test... 08:14:03 INFO - 2015-12-19 08:14:03,788 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIjvRw/profile http://localhost:38606/getInfo.html 08:14:08 INFO - 2015-12-19 08:14:08,225 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:14:08 INFO - 2015-12-19 08:14:08,225 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:14:08 INFO - 2015-12-19 08:14:08,225 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:14:08 INFO - 2015-12-19 08:14:08,225 DEBUG : BROWSER_OUTPUT: __metrics 08:14:08 INFO - 2015-12-19 08:14:08,362 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:08 INFO - 2015-12-19 08:14:08,422 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:09 INFO - 2015-12-19 08:14:09,759 INFO : Browser initialized. 08:14:09 INFO - 2015-12-19 08:14:09,760 INFO : Running cycle 1/1 for kraken test... 08:14:09 INFO - 2015-12-19 08:14:09,760 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIjvRw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:14:21 INFO - 2015-12-19 08:14:21,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 149889024 08:14:21 INFO - 2015-12-19 08:14:21,730 DEBUG : BROWSER_OUTPUT: 08:14:24 INFO - 2015-12-19 08:14:24,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:24 INFO - 2015-12-19 08:14:24,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 184500224 08:14:24 INFO - 2015-12-19 08:14:24,896 DEBUG : BROWSER_OUTPUT: 08:14:27 INFO - 2015-12-19 08:14:27,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-dft) 08:14:28 INFO - 2015-12-19 08:14:28,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 174997504 08:14:28 INFO - 2015-12-19 08:14:28,246 DEBUG : BROWSER_OUTPUT: 08:14:31 INFO - 2015-12-19 08:14:31,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-fft) 08:14:31 INFO - 2015-12-19 08:14:31,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 162037760 08:14:31 INFO - 2015-12-19 08:14:31,793 DEBUG : BROWSER_OUTPUT: 08:14:33 INFO - 2015-12-19 08:14:33,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-oscillator) 08:14:34 INFO - 2015-12-19 08:14:34,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 163172352 08:14:34 INFO - 2015-12-19 08:14:34,399 DEBUG : BROWSER_OUTPUT: 08:14:36 INFO - 2015-12-19 08:14:36,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:37 INFO - 2015-12-19 08:14:37,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 166285312 08:14:37 INFO - 2015-12-19 08:14:37,215 DEBUG : BROWSER_OUTPUT: 08:14:40 INFO - 2015-12-19 08:14:40,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:40 INFO - 2015-12-19 08:14:40,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 166047744 08:14:40 INFO - 2015-12-19 08:14:40,740 DEBUG : BROWSER_OUTPUT: 08:14:44 INFO - 2015-12-19 08:14:44,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:44 INFO - 2015-12-19 08:14:44,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 167546880 08:14:44 INFO - 2015-12-19 08:14:44,748 DEBUG : BROWSER_OUTPUT: 08:14:47 INFO - 2015-12-19 08:14:47,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38606/tests/kraken/driver.html?testName=json-parse-financial) 08:14:48 INFO - 2015-12-19 08:14:48,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 167325696 08:14:48 INFO - 2015-12-19 08:14:48,160 DEBUG : BROWSER_OUTPUT: 08:14:49 INFO - 2015-12-19 08:14:49,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:50 INFO - 2015-12-19 08:14:50,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 174231552 08:14:50 INFO - 2015-12-19 08:14:50,516 DEBUG : BROWSER_OUTPUT: 08:14:52 INFO - 2015-12-19 08:14:52,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:52 INFO - 2015-12-19 08:14:52,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 173465600 08:14:52 INFO - 2015-12-19 08:14:52,959 DEBUG : BROWSER_OUTPUT: 08:14:55 INFO - 2015-12-19 08:14:55,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:55 INFO - 2015-12-19 08:14:55,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 185704448 08:14:55 INFO - 2015-12-19 08:14:55,684 DEBUG : BROWSER_OUTPUT: 08:14:58 INFO - 2015-12-19 08:14:58,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:58 INFO - 2015-12-19 08:14:58,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 191045632 08:14:58 INFO - 2015-12-19 08:14:58,811 DEBUG : BROWSER_OUTPUT: 08:15:01 INFO - 2015-12-19 08:15:01,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:02 INFO - 2015-12-19 08:15:02,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 188362752 08:15:02 INFO - 2015-12-19 08:15:02,016 DEBUG : BROWSER_OUTPUT: 08:15:03 INFO - 2015-12-19 08:15:03,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38606/tests/kraken/driver.html?testName=ai-astar) 08:15:04 INFO - 2015-12-19 08:15:04,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 246886400 08:15:04 INFO - 2015-12-19 08:15:04,021 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:15:04 INFO - 2015-12-19 08:15:04,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:15:04 INFO - 2015-12-19 08:15:04,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:15:04 INFO - 2015-12-19 08:15:04,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:15:04 INFO - 2015-12-19 08:15:04,024 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;104;111;111;111;99;110;112;103 08:15:04 INFO - 2015-12-19 08:15:04,024 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;131;160;163;143;167;163;132;170;129 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;162;161;161;162;161;161;162 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;82;91;74;72;72;97;91;73 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;140;93;94;94;129;94;94;126 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;110;110 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;146;147;146;147;147;147 08:15:04 INFO - 2015-12-19 08:15:04,025 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;71;71;71;72;80;70;70 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;68;68;68;68;68;68;68;68 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;84;84;88;84;92;85;86;86 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;122;128;123;127;123;125;123;128 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;138;151;148;152;139;150;149;149;139 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;73;71;70;69;68;70;69;70 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: __startTimestamp1450541704022__endTimestamp 08:15:04 INFO - 2015-12-19 08:15:04,027 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,028 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:111.50 stddev:4.70 (4.2%) stddev-sans-first:4.81 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 104.0 111.0 111.0 111.0 99.0 110.0 112.0 103.0 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:161.50 stddev:15.97 (9.9%) stddev-sans-first:16.94 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: Values: 150.0 131.0 160.0 163.0 143.0 167.0 163.0 132.0 170.0 129.0 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 162.0 161.0 161.0 162.0 161.0 161.0 162.0 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:78.00 stddev:9.86 (12.6%) stddev-sans-first:10.06 08:15:04 INFO - 2015-12-19 08:15:04,029 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 82.0 91.0 74.0 72.0 72.0 97.0 91.0 73.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:94.00 stddev:18.53 (19.7%) stddev-sans-first:19.28 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 140.0 93.0 94.0 94.0 129.0 94.0 94.0 126.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:71.50 stddev:2.91 (4.1%) stddev-sans-first:3.08 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 71.0 71.0 71.0 72.0 80.0 70.0 70.0 08:15:04 INFO - 2015-12-19 08:15:04,030 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.00 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:2.80 (3.3%) stddev-sans-first:2.67 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 84.0 84.0 88.0 84.0 92.0 85.0 86.0 86.0 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.00 stddev:2.41 (1.9%) stddev-sans-first:2.51 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 122.0 128.0 123.0 127.0 123.0 125.0 123.0 128.0 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,031 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:149.00 stddev:5.72 (3.8%) stddev-sans-first:5.71 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: Values: 140.0 138.0 151.0 148.0 152.0 139.0 150.0 149.0 149.0 139.0 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.41 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 73.0 71.0 70.0 69.0 68.0 70.0 69.0 70.0 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:15:04 INFO - 2015-12-19 08:15:04,032 DEBUG : BROWSER_OUTPUT: 08:15:04 INFO - 2015-12-19 08:15:04,922 INFO : Browser exited with error code: 0 08:15:04 INFO - 2015-12-19 08:15:04,975 INFO : Completed test kraken (00:01:01) 08:15:04 INFO - 2015-12-19 08:15:04,975 INFO : Starting test v8_7 08:15:04 INFO - 2015-12-19 08:15:04,975 DEBUG : operating with platform_type : linux_ 08:15:04 INFO - 2015-12-19 08:15:04,975 INFO : Initialising browser for v8_7 test... 08:15:04 INFO - 2015-12-19 08:15:04,982 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDSNn6/profile http://localhost:38606/getInfo.html 08:15:09 INFO - 2015-12-19 08:15:09,643 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:15:09 INFO - 2015-12-19 08:15:09,643 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:15:09 INFO - 2015-12-19 08:15:09,643 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:15:09 INFO - 2015-12-19 08:15:09,643 DEBUG : BROWSER_OUTPUT: __metrics 08:15:09 INFO - 2015-12-19 08:15:09,772 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:09 INFO - 2015-12-19 08:15:09,840 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:09 ERROR - 2015-12-19 08:15:09,868 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:15:10 INFO - 2015-12-19 08:15:10,803 INFO : Browser initialized. 08:15:10 INFO - 2015-12-19 08:15:10,803 INFO : Running cycle 1/1 for v8_7 test... 08:15:10 INFO - 2015-12-19 08:15:10,804 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDSNn6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:15:22 INFO - 2015-12-19 08:15:22,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 149921792 08:15:22 INFO - 2015-12-19 08:15:22,750 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38606/tests/v8_7/run.html (next: http://localhost:38606/tests/v8_7/run.html) 08:15:44 INFO - 2015-12-19 08:15:44,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 484540416 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 08:15:44 INFO - 2015-12-19 08:15:44,440 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.459940652819 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |8;Splay;628.5355122564425 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:15:44 INFO - 2015-12-19 08:15:44,441 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: __startTimestamp1450541744433__endTimestamp 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: Values: 166.4 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.46 Median:185.46 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: Values: 185.5 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,442 DEBUG : BROWSER_OUTPUT: Values: 279.9 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: Values: 5170.1 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: Values: 1988.1 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,443 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: Values: 786.8 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: Values: 12000.0 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: Values: 27189.2 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:628.54 Median:628.54 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: Values: 628.5 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:15:44 INFO - 2015-12-19 08:15:44,444 DEBUG : BROWSER_OUTPUT: 08:15:45 INFO - 2015-12-19 08:15:45,350 INFO : Browser exited with error code: 0 08:15:45 INFO - 2015-12-19 08:15:45,369 INFO : Completed test v8_7 (00:00:40) 08:15:45 INFO - 2015-12-19 08:15:45,399 INFO : Completed test suite (00:20:19) 08:15:45 INFO - 2015-12-19 08:15:45,399 DEBUG : Working with test: dromaeo_css 08:15:45 INFO - 2015-12-19 08:15:45,399 DEBUG : Generating results file: dromaeo_css 08:15:45 INFO - 2015-12-19 08:15:45,400 DEBUG : Working with test: kraken 08:15:45 INFO - 2015-12-19 08:15:45,400 DEBUG : Generating results file: kraken 08:15:45 INFO - 2015-12-19 08:15:45,401 INFO : javascript benchmark 08:15:45 INFO - 2015-12-19 08:15:45,401 DEBUG : Working with test: v8_7 08:15:45 INFO - 2015-12-19 08:15:45,401 DEBUG : Generating results file: v8_7 08:15:45 INFO - 2015-12-19 08:15:45,401 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:15:45 INFO - 2015-12-19 08:15:45,529 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 08:15:45 INFO - 2015-12-19 08:15:45,529 DEBUG : process_Request line: dromaeo_css 6287.17 graph.html#tests=[[72,203,35]] 08:15:45 INFO - 2015-12-19 08:15:45,529 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:15:45 INFO - 2015-12-19 08:15:45,644 DEBUG : process_Request line: kraken 1522.50 graph.html#tests=[[232,203,35]] 08:15:45 INFO - 2015-12-19 08:15:45,645 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:15:45 INFO - 2015-12-19 08:15:45,758 DEBUG : process_Request line: v8_7 19745.15 graph.html#tests=[[230,203,35]] 08:15:45 INFO - 2015-12-19 08:15:45,760 INFO : javascript benchmark 08:15:45 INFO - 2015-12-19 08:15:45,762 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2620.3580122869894, 2701.257154282573, 2702.405470796425, 2714.9864250678743, 2721.3196700824788, 4466.062126953336, 4599.517050709677, 4670.50959649237, 4707.152712511746, 4714.90570188596, 4599.724016559009, 4612.769361531919, 4696.8590942271785, 4704.529547045294, 4713.670043096985, 4288.120935208275, 4299.763513006791, 4308.741475511463, 4310.56894310568, 4338.826446942135, 4145.854895078673, 4355.932796464871, 4365.585269399402, 4402.735835849843, 4436.334549817521, 4168.478940132483, 4230.111676547928, 4307.547707490731, 4340.13197360526, 4352.173087113439, 4261.74429534229, 4335.978320108379, 4344.956550434518, 4372.519022907478, 4383.693141480097, 4089.795510224477, 4304.5480224576595, 4317.287647538184, 4337.934930976038, 4382.035952090535, 4577.359169716243, 4585.037142200142, 4643.419572553431, 4766.38037055184, 4772.427308722976, 4985.90028199434, 4999.825006124768, 5003.374578177728, 5004.624653151028, 5051.595872330205, 5025.1959686450355, 5031.4465408805, 5037.0429618372755, 5037.143685573425, 5049.772760225798, 4479.9552004479865, 4579.290210017452, 4583.312503124492, 4650.0, 4768.737719425465, 5188.247704082887, 5188.792448302102, 5197.246399272084, 5204.1673332266655, 5252.9737351313, 4978.6763860348965, 4992.850214493571, 5000.199968005175, 5007.39911210657, 5021.84934451967, 4789.712617242976, 4880.951190488121, 4895.0, 4978.800847966041, 5061.544460998528, 4984.77568509418, 5014.799408023711, 5017.297578339036, 5017.422996355393, 5061.342025536656, 4984.22744474607, 4992.375953005874, 4993.026359859865, 4996.07572599063, 5042.319286896222, 4058.228936502055, 4124.0, 4162.188373267244, 4165.770882601486, 4167.416561681367, 3611.7291203159866, 3647.6717095461536, 3649.3431182387426, 3650.7079433645245, 3652.470391793175, 4241.660667146621, 4301.139772045541, 4301.827926882952, 4327.480702315742, 4338.60952514269, 5017.046761115376, 5052.545270925634, 5059.06407314648, 5060.7216603086445, 5109.6678715883345, 4137.193247316744, 4232.32282834745, 4337.457817772778, 4338.240807858612, 4340.435743353344, 4398.582134697199, 4445.488768791631, 4482.013956929471, 4486.977565112154, 4519.977400112978, 4757.238841785298, 4760.381150450419, 4763.071201115749, 4764.14245435818, 4795.064962332382, 4746.359241502491, 4917.557419832232, 5033.597312214941, 5038.47096054909, 5073.036123136592, 4675.976620116878, 4709.693869898582, 4758.714477131383, 4774.116788394158, 4822.035592881508, 4924.753762311799, 4933.753312334297, 4946.332245146859, 4971.229459433794, 4979.402471703419, 4811.927821082617, 4911.115999120193, 5022.874428139179, 5032.119379108714, 5062.0, 4813.807447702053, 4819.180739274261, 4855.902881942412, 4883.853484395474, 4915.557599816034, 4770.189067858541, 4819.373481447389, 4829.372181616508, 4830.661853670209, 4872.293517439881, 4618.122556714214, 4731.195696731633, 4741.099191153669, 4744.501827308083, 4787.664863459524, 4833.854984350475, 4861.635377346643, 4907.386576677915, 4924.162892308244, 4965.702057876539, 4742.644301677319, 4755.262934245197, 4757.215059515142, 4803.3995750531185, 4819.783109759999], "unit": "score", "name": "dojo.html", "value": 4587.369041265194}, {"lowerIsBetter": false, "replicates": [534.1507003863856, 538.3244028743926, 548.9871187658771, 565.3329071695399, 568.5678884048123, 26628.600570991428, 32507.51238731418, 32698.8555400561, 32752.836235818846, 32850.67149328506, 38785.612143878556, 39939.0, 39996.40005399921, 40005.0, 40021.39967900484, 6894.31056894309, 7018.4385249180195, 7848.8037799055055, 8035.919640803576, 8040.276375126237, 10021.799564008716, 10293.742656433611, 10308.0, 10310.845337319908, 10316.638917637883, 9993.550290236957, 10030.648927287546, 10098.697039088802, 10101.0, 10112.544935477885, 7249.456290778213, 7431.777046688608, 7441.069866266716, 9793.461359625218, 10185.38887666735, 9822.214222862154, 9952.950235248778, 9967.302288839785, 9977.700668979942, 9988.850167247498, 37351.813240933894, 37810.81094594537, 37821.0, 37828.243435131146, 37854.62145378539, 2946.528555431142, 3006.834624095674, 3008.443437963962, 3439.7420193485586, 3560.8041557714314, 27715.307117322027, 27977.0, 28261.57607635887, 28349.291267718265, 28579.714202857915, 3346.196912740949, 3364.2598628301735, 3446.9482957755654, 3542.7697199682198, 3561.857525698969, 213223.0, 213306.0, 213574.0, 214390.0, 214616.0, 52547.21179182315, 52794.20808687873, 53111.0, 53157.2026419604, 53161.46838531565, 56078.0, 56258.15612765812, 56306.71846640741, 56431.71784141053, 56459.43540564624, 13700.45198192061, 13754.518591849237, 14014.299285035708, 14056.71886562263, 14084.0, 11321.377324247082, 11393.715157121138, 11399.886001140048, 11401.0, 11403.657890263305, 17492.20124780029, 17838.0, 17873.463796086136, 17883.910580447013, 17957.820421795877, 7093.89359159613, 7292.34368906801, 7325.601142845658, 7339.604966814881, 7379.963100184465, 904.7828521154876, 916.1067958740308, 956.4309236004566, 1009.8992098612548, 1014.5992333028413, 28424.28939276493, 29681.25796855096, 29681.406371872443, 30075.548866767014, 30228.395432091234, 877.912208779117, 963.8939716631165, 973.1873885305707, 1010.9443980581138, 1055.3298655353906, 12368.938155309166, 12639.241645501299, 14159.292035398395, 15091.396344146331, 15303.46437874669, 248452.0, 278018.0, 282678.0, 282806.0, 283632.0, 37227.62772372241, 48401.27398089031, 49179.50820491821, 49203.50796492061, 49469.50530494649, 1210.4189988805422, 1219.4514956945861, 1222.926624402521, 1227.1287385955893, 1229.655696405008, 23234.3029709109, 25038.0, 25642.48715025652, 26478.338041549116, 26936.32659183536, 36069.45895811617, 36372.818135909154, 36379.27241455209, 36422.0, 36429.0, 167676.0, 168349.15825420796, 168646.0, 168687.0, 169038.0, 25654.0, 26059.609105863048, 26063.869680651474, 26079.60880586755, 28483.145505634864, 33765.49351759676, 33923.0, 34080.0, 34464.138396540286, 35944.460833087, 31763.0, 32120.839395802872, 32142.517862232555, 32581.837090814395, 32595.348093037534, 31671.629810574388, 32021.0, 32276.83861580771, 32318.67681323251, 32415.35169296648, 32513.512297316032, 32854.34291314208, 33077.17307067342, 33503.66496335103, 33635.83182084172, 26480.0, 29403.41193176167, 29604.259893502836, 29747.702522974494, 29755.10734677963, 22950.42623934415, 22953.77046229583, 23048.654270185627, 23301.76698232996, 23338.53322933566], "unit": "score", "name": "ext.html", "value": 16830.838329828242}, {"lowerIsBetter": false, "replicates": [318.9027346659268, 320.37207074134693, 325.4873574120759, 325.7849819119382, 333.74635277189327, 14866.925665371671, 15410.075395476279, 16042.51872443827, 16920.746188807178, 16940.152992350362, 14879.851201487982, 15355.769663455028, 15726.84273157268, 15836.84163158368, 15856.762148567752, 4800.207965685658, 4927.063857866994, 4929.876753081184, 4931.827386041471, 4932.926006109911, 4788.0, 4858.951410485903, 4897.975510122445, 4941.6540842140885, 4946.208606622941, 3629.401148810443, 3749.9062523436996, 4919.975400122994, 4925.901481970359, 5660.60375773696, 5863.149843272744, 5889.528837692974, 5910.556708246877, 5917.704114794265, 5929.436703513159, 5021.899562008776, 5032.547070763649, 5033.0, 5034.043531728997, 5129.0767661820855, 14116.647083822883, 14767.187804670739, 18227.54431139219, 18936.71594926077, 19783.20867165326, 1865.347128505026, 1896.0140726822112, 1933.9129739161772, 1999.2602736987262, 2009.2967461388398, 8635.784105397352, 8898.065703101145, 12608.243505389706, 12625.936870315682, 13077.542286019943, 1725.7411388291732, 1731.6536692661518, 1732.7660765796581, 1749.588846621043, 1768.602064535482, 47277.527224728, 49282.7535862322, 50976.64745201737, 58707.70646146742, 59179.1123133149, 9717.368371055858, 9722.465264410384, 9788.608455661837, 9793.363431376938, 9832.410055396698, 12466.81299780504, 12476.750464990831, 12477.376131193403, 12482.75034499323, 12487.687807804878, 7106.0, 7220.855582888313, 7273.199948005715, 7304.8173795654475, 7367.742129025459, 6948.93051069493, 6955.652217389212, 6981.441484681213, 6996.720131194696, 7048.118985126859, 4103.794810259535, 4115.1975364803575, 4116.567760385176, 4127.711060225815, 4138.937915931264, 1691.560194349478, 1703.1143805221216, 1703.3527259641257, 1724.4912750738563, 1744.276125407967, 792.3740245206337, 798.2616080125861, 842.5829214538843, 890.643742502991, 927.1053433436766, 14852.777208341884, 15099.245037748069, 15647.0, 15998.840011599736, 16084.839151608568, 837.9078301386843, 849.4945507423073, 874.9343799214957, 926.2034650200957, 955.4506158958627, 7831.2560306770765, 8846.336524760669, 9219.677311294072, 9429.198518125899, 9548.273421530628, 520292.0, 523792.0, 525689.0, 529404.4119117596, 532761.0, 73792.26207737855, 74156.25843741602, 74759.75720728387, 75220.24779752133, 76261.23738762652, 1051.5373235776235, 1063.3938654966594, 1068.278911734576, 1072.485207100596, 1091.776185881908, 14792.482263120739, 14872.479463219168, 14965.401383944956, 15043.548693539211, 15125.697486050438, 33668.83165584156, 33865.322693546485, 33889.66110338865, 33910.15224619404, 34179.0, 44199.55800442083, 44213.557864420945, 44570.331445029, 46214.0, 47500.28749568828, 8395.370347224105, 8827.382083254111, 8889.511076890833, 8894.688685895962, 8900.243479304332, 10272.22958278147, 10351.792964140524, 15695.843041569895, 16372.508824735278, 16385.50843474698, 12681.556145534862, 12783.872161278268, 12801.48794048265, 13537.526186583422, 14038.438462461387, 13189.0, 13333.733325333633, 13483.932580337429, 13669.589912302647, 13856.930715346762, 13742.587722368346, 13880.722385552433, 14107.0, 14249.0, 14307.070040447337, 8714.0, 8796.516191609522, 8884.0, 9032.36773425854, 9032.412893161923, 9373.484458354857, 9428.10433008863, 9465.621375144918, 12474.5010199591, 13756.518521851687], "unit": "score", "name": "jquery.html", "value": 8295.824749218247}, {"lowerIsBetter": false, "replicates": [1412.7810189420643, 1647.1681800690649, 1698.3291599818072, 1712.7944646642402, 1721.1308289313886, 5775.104858746896, 6933.722651093956, 7277.5269607475475, 7292.525985810918, 7295.89056164158, 7273.418126549876, 7424.146223184335, 7431.665575049122, 7431.814204644887, 7436.405087592993, 1777.83110604493, 1815.6550255451489, 2050.169681279084, 2072.8963551822426, 2081.885496297703, 2136.935891923245, 2141.935741927745, 2143.528423746773, 2143.7534683511362, 2143.882086485243, 2048.795120487947, 2053.425040988518, 2071.3475255294534, 2075.0662202009157, 2084.4893001214723, 1940.40817550647, 1977.5748214133957, 1981.5640559077124, 1998.2206939293687, 2000.449876284019, 2101.6006958677954, 2114.2494414482944, 2125.415510734545, 2126.447123747821, 2133.7012818205462, 7294.452916031266, 7352.77941661751, 7367.152777430557, 7375.520591161558, 7382.151052628909, 4301.698881078326, 4389.341598760179, 4390.0122472443445, 4398.34024896265, 4402.51572327047, 2766.958495622567, 2779.277387879146, 2825.519661657523, 2849.7435230829324, 2858.814177078483, 873.9300855931574, 878.6309749905055, 892.848215803315, 893.7765558610347, 899.3884158772098, 9965.75085622858, 10030.899691003142, 10031.799364012752, 10042.799144017079, 10092.697219083439, 3893.980530097331, 3900.570937196906, 3941.842326306973, 3946.5264168299987, 3950.58518855516, 8636.568171591522, 8647.87577614906, 8658.610362533702, 8661.047284798668, 8670.219680228809, 4373.322135069069, 4380.912381752347, 4401.295792673157, 4408.162449134654, 4408.58118478744, 3952.8616498422416, 3963.009247688078, 3998.9600103998587, 4002.9199416011515, 4005.599440055971, 3023.047739961905, 3094.334718035633, 3347.41420251455, 3429.9314013720086, 3473.548438703003, 1071.3518321415588, 1072.2976450424985, 1074.1621535202555, 1080.1628737728324, 1095.2771171027084, 923.4643906534194, 930.0745757970727, 966.4636126949611, 1172.783035138502, 1183.0771997841698, 6859.176898772179, 6872.0, 6927.411170050602, 6955.721771129098, 6957.373836354753, 972.5817898303656, 981.2052237687353, 1031.582209205273, 1042.1923009667569, 1049.1449468683, 5340.759665815048, 5423.945760542423, 5469.234307196995, 5487.149491828773, 5499.890002199933, 8787.692430764893, 8993.910060899307, 9097.363184577149, 9131.497767622712, 9135.451872887648, 8777.868331975025, 8857.689980850768, 8969.103089691109, 9027.593758280893, 9039.864402033974, 6954.79135625932, 6958.47811414146, 6960.234374218832, 7014.088168538057, 7040.718371265194, 6564.901526477202, 6612.173478315211, 6672.366125218096, 6701.731930722716, 6735.158105236846, 7159.17669467997, 7689.50018248812, 7918.802029949067, 7993.840123197388, 8019.318357939641, 7712.9614351927885, 7766.805829854073, 7850.293473587404, 7997.520148791091, 8186.508809471451, 6903.585784852925, 6980.860382792214, 6994.965025174842, 7000.089988301692, 7015.508914376149, 5940.702964851826, 5974.850628734316, 6089.33017368098, 6837.487188460786, 7081.82295442618, 6194.5044396449075, 6530.281669016309, 6770.6614669265355, 6858.862822743617, 6897.241303456515, 6604.0754294399785, 6627.6354800484505, 6636.2368327642935, 6710.865782684416, 6783.525153239226, 6598.076269322395, 6603.867922641616, 6619.536632435684, 6629.6353700545005, 6634.436072933855, 6195.721192546436, 6216.378362163748, 6218.657973811484, 6222.0, 6229.781957631461, 6080.300765412034, 6222.657753823583, 6223.097650840512, 6243.188385510036, 6247.9062814056915], "unit": "score", "name": "mootools.html", "value": 4183.997800716987}, {"lowerIsBetter": false, "replicates": [293.9764818814495, 300.3527398456326, 301.96829332920043, 307.1063206070336, 309.35190775325685, 5201.42682531368, 5228.189630607258, 5284.969430960964, 5302.575793936486, 5309.787608495665, 5220.582353411727, 5228.424873263938, 5236.92144617831, 5241.606879484035, 5252.080885844981, 3882.941755873664, 4124.546299907008, 4134.111166099288, 4139.565345638703, 4141.834326626931, 3998.300297447935, 4008.1783234437016, 4137.937930931039, 4144.357624568197, 4151.2112698587325, 4103.302438585448, 4103.38449232616, 4105.486814148231, 4113.341865301552, 4116.094459218982, 3879.573246942834, 3963.623455771697, 3969.0, 4109.3425051991535, 4110.1163249901265, 3628.310620982005, 3629.038304849217, 3651.488791569156, 3653.1962968146963, 3654.5979942206336, 5049.949500505021, 5065.1642478990925, 5067.6452648314635, 5072.695638261679, 5074.974625126888, 4730.455997560291, 4733.100710864925, 4734.384530011076, 4738.3603213566075, 4741.834035808764, 5321.148616221386, 5511.724413779295, 5525.254090697745, 5528.502434780889, 5533.667979921177, 3859.186182494251, 3860.5946375630715, 3860.976841137101, 3860.9806950965344, 3861.8455261789495, 5718.142278658193, 5797.942020579824, 5803.100519419497, 5803.709814509258, 5807.448292412214, 3965.643092121723, 3975.1254723960683, 3976.741511801724, 3976.980115099406, 3979.343408337592, 3938.310795610814, 4034.1528279061727, 4034.5158580969883, 4034.536028356718, 4038.697097717683, 4627.0, 4632.3977882875015, 4636.095961287584, 4639.072185562901, 4639.466461356919, 5508.091164957737, 5516.0, 5516.117421212667, 5518.972405137949, 5519.641223320471, 1393.7003544238037, 1419.2265215457394, 1421.8293804743496, 1422.2462095089413, 1422.2746399336413, 929.4980710416435, 931.5761328595473, 944.4333399959969, 975.3903810118676, 976.4873441443157, 4827.227643577011, 4833.10587541299, 4838.540338667821, 4839.975800120977, 4842.080004799077, 5708.857278568069, 5720.08478643415, 5720.971395142998, 5722.37053924068, 5725.3988331225455, 4806.110869489155, 4821.276808478756, 4825.5898248649255, 4829.6860704054125, 4832.710037397767, 2885.6183218297724, 2985.462616728966, 3050.694930506976, 3077.2153100959113, 3078.4766589679807, 4805.6155507559315, 5482.958237934779, 5483.0, 5488.780448782004, 5498.0, 5919.3192782829665, 5927.8221653350465, 5928.081147422156, 5941.554383421174, 5943.613665111754, 5475.589330800126, 5475.835724928259, 5483.424240454695, 5489.984352894728, 5490.286262785812, 5558.221848941233, 5746.971265143815, 5773.364929857628, 5776.046952252831, 5783.392743761844, 5635.549156067586, 5638.661680299195, 5640.266765320646, 5640.689762063126, 5643.887122257614, 5488.780448782004, 5492.0663487206475, 5492.972535137458, 5496.395396506461, 5498.780048798003, 3924.293627147141, 3967.6032396761248, 3968.543617484026, 3969.345058065502, 3971.9205615886945, 5509.917351239815, 5655.179998900218, 5755.884882302246, 5756.222909907109, 5762.740676669644, 5393.9730301348245, 5459.808906688247, 5464.1257398816, 5468.48049435303, 5530.087535556749, 5382.703951282717, 5510.311211098613, 5549.417311182429, 5549.5837812163445, 5553.805616803393, 5335.546478549367, 5395.757190926339, 5437.5378092860965, 5442.5645948323245, 5445.591580631548, 5550.417206193453, 5592.077307244259, 5593.804216852391, 5596.384397716167, 5598.86002849932, 5446.400895901368, 5456.945430545644, 5458.754356054066, 5461.9180712290145, 5466.863328416822], "unit": "score", "name": "prototype.html", "value": 4156.625918603198}, {"lowerIsBetter": false, "replicates": [652.5562617420154, 656.3174298729322, 695.2421860172411, 774.3456779021725, 796.3191471292041, 10748.086412654924, 11007.174461915349, 11010.119190464764, 11056.502457389417, 11058.447077646115, 10087.495625218746, 10547.945205479447, 10695.037446629802, 11098.500567474463, 11128.944355278232, 782.9373650107992, 804.3042768005662, 804.3082948664144, 804.6057431858405, 804.9195080491962, 773.9922600773976, 783.5416281475316, 787.7715462515863, 788.1094363369384, 788.6056971514242, 810.2464707821723, 827.1273806134526, 829.7344849648115, 829.7676650537859, 830.485099238473, 819.5451524403924, 820.2945466898523, 820.5240960243045, 820.7209548753423, 820.7742870710542, 608.8995315772892, 610.2432983100967, 610.7160170520684, 610.8137018209444, 610.9053096770008, 9726.9513652432, 9739.951300243525, 9742.07450292221, 9844.556994935245, 9850.60597576096, 8651.913480865236, 8814.779630509225, 9092.181703646638, 9437.528123593793, 9922.603095876157, 8517.105703901125, 8585.871211931826, 8622.913770862273, 8624.741257762276, 8687.391882568223, 3043.284828065425, 3121.719045285935, 3179.3959147761852, 3182.965536200721, 3185.904422867318, 34752.30495390078, 35473.82263088668, 38107.23785524274, 38137.23725525474, 38432.61567384318, 9019.233365163904, 9176.17414432691, 9225.953870230605, 9376.484293363794, 9440.90559094414, 16305.918470407572, 16322.183890805649, 16345.591360215853, 16351.26419311134, 16363.754543681855, 5330.016434633552, 5636.205812804992, 6367.586106903036, 6433.388828061326, 6568.244651865001, 3701.2597480504005, 3708.721845861571, 3724.478572999782, 3737.3459644562095, 3845.942310865339, 2654.7477989590957, 2680.209338245222, 2682.7049024607277, 2683.0475181310744, 2688.5160671079, 452.8211356514224, 464.80478199156437, 468.11526215452824, 473.4862673998681, 474.1749356120326, 531.6119232959884, 547.1764993684479, 555.686037388882, 565.4938829747435, 604.3291945940003, 7114.750983715545, 7160.57036577807, 7245.166805817293, 7378.1121615601005, 7494.587797671181, 572.9799457019068, 579.4292621767555, 579.5421616922669, 580.3963877567367, 588.1325045557768, 3388.186835159593, 3401.795892246473, 3442.7417943654327, 3489.668481494254, 3561.5370001900105, 47529.762351188714, 48181.759091204316, 48202.517974819806, 48316.0, 48452.757736211795, 42984.785076075044, 43019.92450188708, 43415.131697365876, 44057.0, 44183.33724994128, 36703.449448258296, 37000.0, 42820.35769463461, 44466.3330050043, 45238.77380613076, 7824.92175078242, 7842.725504607311, 7899.052113746157, 8063.637136328762, 8244.093149753642, 26231.213063608124, 30381.088567343017, 30923.84538077385, 31016.379672406878, 31104.22239444032, 32612.34775304528, 36169.63830361768, 36241.0, 36773.0, 37028.00121983606, 10019.448930308903, 10231.641892534024, 10425.687229383131, 10472.0, 10961.83557246626, 11099.445027748741, 11294.0, 11425.37160456183, 11511.251768635011, 12011.159218854946, 10266.43534605574, 10499.632512862014, 10615.575376984834, 11018.669439916815, 11070.501827417947, 10338.379697218192, 10482.318649287772, 10727.40999245049, 10853.131749459866, 10855.0, 10324.296491079189, 10775.6228532001, 10787.568497260021, 10796.0, 10842.620508282173, 8619.1811777881, 8750.124987501198, 8762.386632935633, 8893.0, 8904.421212621159, 9004.954975225082, 9032.0, 9119.726408207764, 9219.0, 9255.35212535116], "unit": "score", "name": "yui.html", "value": 5544.004285349707}], "name": "dromaeo_css", "value": 6287.166849158819}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 104.0, 111.0, 111.0, 111.0, 99.0, 110.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 160.0, 163.0, 143.0, 167.0, 163.0, 132.0, 170.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 82.0, 91.0, 74.0, 72.0, 72.0, 97.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 140.0, 93.0, 94.0, 94.0, 129.0, 94.0, 94.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 71.0, 72.0, 80.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 84.0, 88.0, 84.0, 92.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 122.0, 128.0, 123.0, 127.0, 123.0, 125.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [140.0, 138.0, 151.0, 148.0, 152.0, 139.0, 150.0, 149.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 73.0, 71.0, 70.0, 69.0, 68.0, 70.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1522.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [185.459940652819], "unit": "score", "name": "DeltaBlue", "value": 356.508256}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [628.5355122564425], "unit": "score", "name": "Splay", "value": 129.65218100000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19745.150874904546}]} 08:15:45 INFO - RETURN: dromaeo_css: 6287.17 08:15:45 INFO - RETURN: kraken: 1522.50 08:15:45 INFO - RETURN: v8_7: 19745.15 08:15:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19745.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1522.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6287.17"}}} 08:15:45 INFO - Return code: 0 08:15:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:15:45 ERROR - # TBPL SUCCESS # 08:15:45 INFO - Running post-action listener: _resource_record_post_action 08:15:45 INFO - Running post-run listener: _resource_record_post_run 08:15:46 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559886336; Read time: 16; Write time: 818788 08:15:46 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240111616; Read time: 0; Write time: 412440 08:15:47 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315768832; Read time: 16; Write time: 405756 08:15:47 INFO - Running post-run listener: _upload_blobber_files 08:15:47 INFO - Blob upload gear active. 08:15:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:15:47 INFO - Copying logs to upload dir... 08:15:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.918305 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-19 08:15:46.745630) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 08:15:46.748978) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010043 build_url: 'https://queue.taskcluster.net/v1/task/1j08C0AzRc23UJlfGTuoXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 08:15:46.801184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 08:15:46.801521) ========= 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=d96ba47f58e561e1fc64d816000001cc-1450539829.433415-1472802853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 08:15:46.851385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 08:15:46.851741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 08:15:46.852082) ========= ========= Total master_lag: 0.23 =========