builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1450450182.12 results: success (0) buildid: 20151218054455 builduid: 579bc684797c495ab00b31a82bb05dbd revision: 5e54bf9610922270015d0c3ba3e9dadcb674179d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.121486) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.122071) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.122426) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006438 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.154712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.155091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.271521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.271833) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.327978) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.331403) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.331877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.332247) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 06:49:42-- 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% 221M=0s 2015-12-18 06:49:42 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.460068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.460391) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.511354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:42.511763) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5e54bf9610922270015d0c3ba3e9dadcb674179d --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 5e54bf9610922270015d0c3ba3e9dadcb674179d --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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 06:49:42,774 truncating revision to first 12 chars 2015-12-18 06:49:42,774 Setting DEBUG logging. 2015-12-18 06:49:42,774 attempt 1/10 2015-12-18 06:49:42,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5e54bf961092?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 06:49:43,256 unpacking tar archive at: b2g-inbound-5e54bf961092/testing/mozharness/ program finished with exit code 0 elapsedTime=0.757886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:43.283424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:43.283771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:43.292405) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:43.292728) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:49:43.293241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 06:49:43.293598) ========= /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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:43 INFO - MultiFileLogger online at 20151218 06:49:43 in /builds/slave/test 06:49:43 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 06:49:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:43 INFO - {'append_to_log': False, 06:49:43 INFO - 'base_work_dir': '/builds/slave/test', 06:49:43 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 06:49:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:43 INFO - 'branch': 'B2G-Inbound-Non-PGO', 06:49:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:43 INFO - 'config_files': ('talos/linux_config.py',), 06:49:43 INFO - 'default_actions': ('clobber', 06:49:43 INFO - 'read-buildbot-config', 06:49:43 INFO - 'download-and-extract', 06:49:43 INFO - 'populate-webroot', 06:49:43 INFO - 'create-virtualenv', 06:49:43 INFO - 'install', 06:49:43 INFO - 'run-tests'), 06:49:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:43 INFO - 'download_minidump_stackwalk': True, 06:49:43 INFO - 'download_symbols': 'ondemand', 06:49:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:43 INFO - 'installer_path': 'installer.exe', 06:49:43 INFO - 'log_level': 'info', 06:49:43 INFO - 'log_name': 'talos', 06:49:43 INFO - 'log_to_console': True, 06:49:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:43 INFO - 'opt_config_files': (), 06:49:43 INFO - 'pip_index': False, 06:49:43 INFO - 'sps_profile': False, 06:49:43 INFO - 'sps_profile_interval': 0, 06:49:43 INFO - 'suite': 'dromaeojs', 06:49:43 INFO - 'system_bits': '64', 06:49:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:43 INFO - 'title': 'talos-linux64-ix-014', 06:49:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:43 INFO - 'use_talos_json': True, 06:49:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:43 INFO - 'work_dir': 'build'} 06:49:43 INFO - ##### 06:49:43 INFO - ##### Running clobber step. 06:49:43 INFO - ##### 06:49:43 INFO - Running pre-action listener: _resource_record_pre_action 06:49:43 INFO - Running main action method: clobber 06:49:43 INFO - rmtree: /builds/slave/test/build 06:49:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:44 INFO - Running post-action listener: _resource_record_post_action 06:49:44 INFO - ##### 06:49:44 INFO - ##### Running read-buildbot-config step. 06:49:44 INFO - ##### 06:49:44 INFO - Running pre-action listener: _resource_record_pre_action 06:49:44 INFO - Running main action method: read_buildbot_config 06:49:44 INFO - Using buildbot properties: 06:49:44 INFO - { 06:49:44 INFO - "project": "", 06:49:44 INFO - "product": "firefox", 06:49:44 INFO - "script_repo_revision": "production", 06:49:44 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 06:49:44 INFO - "repository": "", 06:49:44 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 06:49:44 INFO - "buildid": "20151218054455", 06:49:44 INFO - "pgo_build": "False", 06:49:44 INFO - "basedir": "/builds/slave/test", 06:49:44 INFO - "buildnumber": 788, 06:49:44 INFO - "slavename": "talos-linux64-ix-014", 06:49:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:49:44 INFO - "platform": "ubuntu64_hw", 06:49:44 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 06:49:44 INFO - "branch": "b2g-inbound", 06:49:44 INFO - "repo_path": "integration/b2g-inbound", 06:49:44 INFO - "revision": "5e54bf9610922270015d0c3ba3e9dadcb674179d", 06:49:44 INFO - "stage_platform": "linux64", 06:49:44 INFO - "builduid": "579bc684797c495ab00b31a82bb05dbd", 06:49:44 INFO - "slavebuilddir": "test" 06:49:44 INFO - } 06:49:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:49:44 INFO - Running post-action listener: _resource_record_post_action 06:49:44 INFO - ##### 06:49:44 INFO - ##### Running download-and-extract step. 06:49:44 INFO - ##### 06:49:44 INFO - Running pre-action listener: _resource_record_pre_action 06:49:44 INFO - Running main action method: download_and_extract 06:49:44 INFO - mkdir: /builds/slave/test/build/tests 06:49: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')]} 06:49:44 INFO - https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/test_packages.json 06:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/test_packages.json 06:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:49:45 INFO - Downloaded 1302 bytes. 06:49:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:49:45 INFO - Using the following test package requirements: 06:49:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'jsshell-linux-x86_64.zip'], 06:49:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:45 INFO - https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:46 INFO - Downloaded 21871027 bytes. 06:49:46 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 06:49:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:46 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 06:49:47 INFO - Return code: 0 06:49:47 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 06:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:47 INFO - https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:49 INFO - Downloaded 21871027 bytes. 06:49:49 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 06:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:49 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 06:49:50 INFO - Return code: 0 06:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:50 INFO - https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:52 INFO - Downloaded 11132039 bytes. 06:49:52 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 06:49:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:52 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 06:49:52 INFO - Return code: 0 06:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:52 INFO - https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/r6aewZTjQoeFV8bg2liNdw/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 06:49:55 INFO - Downloaded 53024259 bytes. 06:49:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:55 INFO - mkdir: /builds/slave/test/properties 06:49:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:55 INFO - Contents: 06:49:55 INFO - build_url:https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:55 INFO - Running post-action listener: _resource_record_post_action 06:49:55 INFO - Running post-action listener: set_extra_try_arguments 06:49:55 INFO - ##### 06:49:55 INFO - ##### Running populate-webroot step. 06:49:55 INFO - ##### 06:49:55 INFO - Running pre-action listener: _resource_record_pre_action 06:49:55 INFO - Running main action method: populate_webroot 06:49:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:55 INFO - '--tppagecycles', 06:49:55 INFO - '7'], 06:49:55 INFO - 'tests': ['tsvgm']}}, 06:49:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'tests': ['damp', 'tps']}, 06:49:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['damp', 'tps']}, 06:49:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:55 INFO - 'other': {'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'other_l64': {'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:55 INFO - 'ts_paint', 06:49:55 INFO - 'tpaint', 06:49:55 INFO - 'sessionrestore', 06:49:55 INFO - 'sessionrestore_no_auto_restore']}, 06:49:55 INFO - 'svgr': {'tests': ['tsvgx', 06:49:55 INFO - 'tsvgr_opacity', 06:49:55 INFO - 'tart', 06:49:55 INFO - 'tscrollx', 06:49:55 INFO - 'cart']}, 06:49:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['tsvgx', 06:49:55 INFO - 'tsvgr_opacity', 06:49:55 INFO - 'tart', 06:49:55 INFO - 'tscrollx', 06:49:55 INFO - 'cart']}, 06:49:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'tests': ['tp5o']}, 06:49:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'talos_options': ['--e10s'], 06:49:55 INFO - 'tests': ['tp5o']}, 06:49:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'talos_options': ['--xperf_path', 06:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:55 INFO - 'tests': ['tp5n']}, 06:49:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:55 INFO - 'talos_options': ['--e10s', 06:49:55 INFO - '--xperf_path', 06:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:55 INFO - 'tests': ['tp5n']}}, 06:49:55 INFO - 'talos.zip': {'path': '', 06:49:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:55 INFO - Running post-action listener: _resource_record_post_action 06:49:55 INFO - ##### 06:49:55 INFO - ##### Running create-virtualenv step. 06:49:55 INFO - ##### 06:49:55 INFO - Running pre-action listener: _resource_record_pre_action 06:49:55 INFO - Running main action method: create_virtualenv 06:49:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:55 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 06:49:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:55 INFO - Using real prefix '/usr' 06:49:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:58 INFO - Installing pip.................done. 06:49:58 INFO - Return code: 0 06:49:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:49:58 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 06:49:58 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 06:49:58 INFO - Using env: {'DISPLAY': ':0', 06:49:58 INFO - 'HOME': '/home/cltbld', 06:49:58 INFO - 'LANG': 'en_US.UTF-8', 06:49:58 INFO - 'LANGUAGE': 'en_US:en', 06:49:58 INFO - 'LOGNAME': 'cltbld', 06:49:58 INFO - 'MAIL': '/var/mail/cltbld', 06:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:58 INFO - 'MOZ_NO_REMOTE': '1', 06:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:58 INFO - 'NO_EM_RESTART': '1', 06:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:58 INFO - 'PWD': '/builds/slave/test', 06:49:58 INFO - 'SHELL': '/bin/bash', 06:49:58 INFO - 'SHLVL': '1', 06:49:58 INFO - 'TERM': 'linux', 06:49:58 INFO - 'TMOUT': '86400', 06:49:58 INFO - 'USER': 'cltbld', 06:49:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:58 INFO - '_': '/tools/buildbot/bin/python'} 06:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:58 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 06:49:58 INFO - Cleaning up... 06:49:58 INFO - Return code: 0 06:49:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:49:58 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 06:49:58 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 06:49:58 INFO - Using env: {'DISPLAY': ':0', 06:49:58 INFO - 'HOME': '/home/cltbld', 06:49:58 INFO - 'LANG': 'en_US.UTF-8', 06:49:58 INFO - 'LANGUAGE': 'en_US:en', 06:49:58 INFO - 'LOGNAME': 'cltbld', 06:49:58 INFO - 'MAIL': '/var/mail/cltbld', 06:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:58 INFO - 'MOZ_NO_REMOTE': '1', 06:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:58 INFO - 'NO_EM_RESTART': '1', 06:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:58 INFO - 'PWD': '/builds/slave/test', 06:49:58 INFO - 'SHELL': '/bin/bash', 06:49:58 INFO - 'SHLVL': '1', 06:49:58 INFO - 'TERM': 'linux', 06:49:58 INFO - 'TMOUT': '86400', 06:49:58 INFO - 'USER': 'cltbld', 06:49:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:58 INFO - '_': '/tools/buildbot/bin/python'} 06:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:58 INFO - Downloading/unpacking psutil>=0.7.1 06:49:58 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 06:49:58 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 06:49:58 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 06:49:58 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 06:49:58 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 06:49:58 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 06:50:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:00 INFO - Installing collected packages: psutil 06:50:00 INFO - Running setup.py install for psutil 06:50:00 INFO - building 'psutil._psutil_linux' extension 06:50:00 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 06:50:00 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 06:50:00 INFO - building 'psutil._psutil_posix' extension 06:50:00 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 06:50:00 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 06:50:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:01 INFO - Successfully installed psutil 06:50:01 INFO - Cleaning up... 06:50:01 INFO - Return code: 0 06:50:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:01 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:01 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 06:50:01 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 06:50:01 INFO - Using env: {'DISPLAY': ':0', 06:50:01 INFO - 'HOME': '/home/cltbld', 06:50:01 INFO - 'LANG': 'en_US.UTF-8', 06:50:01 INFO - 'LANGUAGE': 'en_US:en', 06:50:01 INFO - 'LOGNAME': 'cltbld', 06:50:01 INFO - 'MAIL': '/var/mail/cltbld', 06:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:01 INFO - 'MOZ_NO_REMOTE': '1', 06:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:01 INFO - 'NO_EM_RESTART': '1', 06:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:01 INFO - 'PWD': '/builds/slave/test', 06:50:01 INFO - 'SHELL': '/bin/bash', 06:50:01 INFO - 'SHLVL': '1', 06:50:01 INFO - 'TERM': 'linux', 06:50:01 INFO - 'TMOUT': '86400', 06:50:01 INFO - 'USER': 'cltbld', 06:50:01 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:01 INFO - '_': '/tools/buildbot/bin/python'} 06:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:03 INFO - Installing collected packages: mozsystemmonitor 06:50:03 INFO - Running setup.py install for mozsystemmonitor 06:50:03 INFO - Successfully installed mozsystemmonitor 06:50:03 INFO - Cleaning up... 06:50:03 INFO - Return code: 0 06:50:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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', '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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:50: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 blobuploader==1.2.4 06:50:03 INFO - Using env: {'DISPLAY': ':0', 06:50:03 INFO - 'HOME': '/home/cltbld', 06:50:03 INFO - 'LANG': 'en_US.UTF-8', 06:50:03 INFO - 'LANGUAGE': 'en_US:en', 06:50:03 INFO - 'LOGNAME': 'cltbld', 06:50:03 INFO - 'MAIL': '/var/mail/cltbld', 06:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:03 INFO - 'MOZ_NO_REMOTE': '1', 06:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:03 INFO - 'NO_EM_RESTART': '1', 06:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:03 INFO - 'PWD': '/builds/slave/test', 06:50:03 INFO - 'SHELL': '/bin/bash', 06:50:03 INFO - 'SHLVL': '1', 06:50:03 INFO - 'TERM': 'linux', 06:50:03 INFO - 'TMOUT': '86400', 06:50:03 INFO - 'USER': 'cltbld', 06:50:03 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:03 INFO - '_': '/tools/buildbot/bin/python'} 06:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:05 INFO - Downloading docopt-0.6.1.tar.gz 06:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:05 INFO - Running setup.py install for blobuploader 06:50:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:05 INFO - Running setup.py install for requests 06:50:06 INFO - Running setup.py install for docopt 06:50:06 INFO - Successfully installed blobuploader requests docopt 06:50:06 INFO - Cleaning up... 06:50:06 INFO - Return code: 0 06:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:06 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 06:50:06 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 06:50:06 INFO - Using env: {'DISPLAY': ':0', 06:50:06 INFO - 'HOME': '/home/cltbld', 06:50:06 INFO - 'LANG': 'en_US.UTF-8', 06:50:06 INFO - 'LANGUAGE': 'en_US:en', 06:50:06 INFO - 'LOGNAME': 'cltbld', 06:50:06 INFO - 'MAIL': '/var/mail/cltbld', 06:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:06 INFO - 'MOZ_NO_REMOTE': '1', 06:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:06 INFO - 'NO_EM_RESTART': '1', 06:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:06 INFO - 'PWD': '/builds/slave/test', 06:50:06 INFO - 'SHELL': '/bin/bash', 06:50:06 INFO - 'SHLVL': '1', 06:50:06 INFO - 'TERM': 'linux', 06:50:06 INFO - 'TMOUT': '86400', 06:50:06 INFO - 'USER': 'cltbld', 06:50:06 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:06 INFO - '_': '/tools/buildbot/bin/python'} 06:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:06 INFO - Running setup.py (path:/tmp/pip-dvVydI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:06 INFO - Running setup.py (path:/tmp/pip-v6oFiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:06 INFO - Running setup.py (path:/tmp/pip-5scNne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:06 INFO - Running setup.py (path:/tmp/pip-PGeiJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:06 INFO - Running setup.py (path:/tmp/pip-UAikDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:07 INFO - Running setup.py (path:/tmp/pip-eAEzqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:07 INFO - Running setup.py (path:/tmp/pip-qtFntB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:07 INFO - Running setup.py (path:/tmp/pip-RhYU85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:07 INFO - Running setup.py (path:/tmp/pip-DJJa7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:07 INFO - Running setup.py (path:/tmp/pip-UDqEmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:07 INFO - Running setup.py (path:/tmp/pip-V9ygQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:07 INFO - Running setup.py (path:/tmp/pip-YsAyYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:07 INFO - Running setup.py (path:/tmp/pip-7r7dSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:07 INFO - Running setup.py (path:/tmp/pip-uA1O9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:07 INFO - Running setup.py (path:/tmp/pip-CRQ_uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:07 INFO - Running setup.py (path:/tmp/pip-0cPfuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:07 INFO - Running setup.py (path:/tmp/pip-b50RpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:07 INFO - Running setup.py install for manifestparser 06:50:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for mozcrash 06:50:08 INFO - Running setup.py install for mozdebug 06:50:08 INFO - Running setup.py install for mozdevice 06:50:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for mozfile 06:50:08 INFO - Running setup.py install for mozhttpd 06:50:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for mozinfo 06:50:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for mozInstall 06:50:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for mozleak 06:50:08 INFO - Running setup.py install for mozlog 06:50:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:08 INFO - Running setup.py install for moznetwork 06:50:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Running setup.py install for mozprocess 06:50:09 INFO - Running setup.py install for mozprofile 06:50:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Running setup.py install for mozrunner 06:50:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Running setup.py install for mozscreenshot 06:50:09 INFO - Running setup.py install for moztest 06:50:09 INFO - Running setup.py install for mozversion 06:50:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:09 INFO - Cleaning up... 06:50:09 INFO - Return code: 0 06:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:09 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')]} 06:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:09 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')]} 06:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:09 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:09 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 06:50:09 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 06:50:09 INFO - Using env: {'DISPLAY': ':0', 06:50:09 INFO - 'HOME': '/home/cltbld', 06:50:09 INFO - 'LANG': 'en_US.UTF-8', 06:50:09 INFO - 'LANGUAGE': 'en_US:en', 06:50:09 INFO - 'LOGNAME': 'cltbld', 06:50:09 INFO - 'MAIL': '/var/mail/cltbld', 06:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:09 INFO - 'MOZ_NO_REMOTE': '1', 06:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:09 INFO - 'NO_EM_RESTART': '1', 06:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:09 INFO - 'PWD': '/builds/slave/test', 06:50:09 INFO - 'SHELL': '/bin/bash', 06:50:09 INFO - 'SHLVL': '1', 06:50:09 INFO - 'TERM': 'linux', 06:50:09 INFO - 'TMOUT': '86400', 06:50:09 INFO - 'USER': 'cltbld', 06:50:09 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:09 INFO - '_': '/tools/buildbot/bin/python'} 06:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:09 INFO - Running setup.py (path:/tmp/pip-rccdxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:09 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)) 06:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:09 INFO - Running setup.py (path:/tmp/pip-Z8aEkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:10 INFO - Running setup.py (path:/tmp/pip-mfxkq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:10 INFO - Running setup.py (path:/tmp/pip-p9bBdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:10 INFO - Running setup.py (path:/tmp/pip-RRRupS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:10 INFO - Running setup.py (path:/tmp/pip-QlkjeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:10 INFO - Running setup.py (path:/tmp/pip-0i8Vuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:10 INFO - Running setup.py (path:/tmp/pip-jwTWEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:10 INFO - Running setup.py (path:/tmp/pip-hpRTtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:10 INFO - Running setup.py (path:/tmp/pip-IhqwxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:10 INFO - Running setup.py (path:/tmp/pip-gYBuLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:10 INFO - Running setup.py (path:/tmp/pip-4LC0LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:10 INFO - Running setup.py (path:/tmp/pip-ZDwkRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:10 INFO - Running setup.py (path:/tmp/pip-BDeA_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:10 INFO - Running setup.py (path:/tmp/pip-iGgiKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:10 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)) 06:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:10 INFO - Running setup.py (path:/tmp/pip-y2UvDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:11 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)) 06:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:11 INFO - Running setup.py (path:/tmp/pip-ImEzuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:12 INFO - Downloading blessings-1.5.1.tar.gz 06:50:12 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 06:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:12 INFO - Installing collected packages: blessings 06:50:12 INFO - Running setup.py install for blessings 06:50:12 INFO - Successfully installed blessings 06:50:12 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:13 INFO - Reading from file tmpfile_stdout 06:50:13 INFO - Current package versions: 06:50:13 INFO - argparse == 1.2.1 06:50:13 INFO - blessings == 1.5.1 06:50:13 INFO - blobuploader == 1.2.4 06:50:13 INFO - docopt == 0.6.1 06:50:13 INFO - manifestparser == 1.1 06:50:13 INFO - mozInstall == 1.12 06:50:13 INFO - mozcrash == 0.16 06:50:13 INFO - mozdebug == 0.1 06:50:13 INFO - mozdevice == 0.47 06:50:13 INFO - mozfile == 1.2 06:50:13 INFO - mozhttpd == 0.7 06:50:13 INFO - mozinfo == 0.9 06:50:13 INFO - mozleak == 0.1 06:50:13 INFO - mozlog == 3.1 06:50:13 INFO - moznetwork == 0.27 06:50:13 INFO - mozprocess == 0.22 06:50:13 INFO - mozprofile == 0.27 06:50:13 INFO - mozrunner == 6.11 06:50:13 INFO - mozscreenshot == 0.1 06:50:13 INFO - mozsystemmonitor == 0.0 06:50:13 INFO - moztest == 0.7 06:50:13 INFO - mozversion == 1.4 06:50:13 INFO - psutil == 3.1.1 06:50:13 INFO - requests == 1.2.3 06:50:13 INFO - wsgiref == 0.1.2 06:50:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:13 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 06:50:13 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 06:50:13 INFO - Using env: {'DISPLAY': ':0', 06:50:13 INFO - 'HOME': '/home/cltbld', 06:50:13 INFO - 'LANG': 'en_US.UTF-8', 06:50:13 INFO - 'LANGUAGE': 'en_US:en', 06:50:13 INFO - 'LOGNAME': 'cltbld', 06:50:13 INFO - 'MAIL': '/var/mail/cltbld', 06:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:13 INFO - 'MOZ_NO_REMOTE': '1', 06:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:13 INFO - 'NO_EM_RESTART': '1', 06:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:13 INFO - 'PWD': '/builds/slave/test', 06:50:13 INFO - 'SHELL': '/bin/bash', 06:50:13 INFO - 'SHLVL': '1', 06:50:13 INFO - 'TERM': 'linux', 06:50:13 INFO - 'TMOUT': '86400', 06:50:13 INFO - 'USER': 'cltbld', 06:50:13 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:13 INFO - '_': '/tools/buildbot/bin/python'} 06:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:13 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 06:50:13 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 06:50:13 INFO - Using env: {'DISPLAY': ':0', 06:50:13 INFO - 'HOME': '/home/cltbld', 06:50:13 INFO - 'LANG': 'en_US.UTF-8', 06:50:13 INFO - 'LANGUAGE': 'en_US:en', 06:50:13 INFO - 'LOGNAME': 'cltbld', 06:50:13 INFO - 'MAIL': '/var/mail/cltbld', 06:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:13 INFO - 'MOZ_NO_REMOTE': '1', 06:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:13 INFO - 'NO_EM_RESTART': '1', 06:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:13 INFO - 'PWD': '/builds/slave/test', 06:50:13 INFO - 'SHELL': '/bin/bash', 06:50:13 INFO - 'SHLVL': '1', 06:50:13 INFO - 'TERM': 'linux', 06:50:13 INFO - 'TMOUT': '86400', 06:50:13 INFO - 'USER': 'cltbld', 06:50:13 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:13 INFO - '_': '/tools/buildbot/bin/python'} 06:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:13 INFO - Downloading/unpacking jsonschema 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:15 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 06:50:15 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 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 06:50:15 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:15 INFO - warning: no files found matching '*.txt' 06:50:15 INFO - no previously-included directories found matching 'build' 06:50:15 INFO - no previously-included directories found matching 'dist' 06:50:15 INFO - no previously-included directories found matching '.git*' 06:50:15 INFO - Installing collected packages: jsonschema, functools32 06:50:15 INFO - Running setup.py install for functools32 06:50:15 INFO - warning: no files found matching '*.txt' 06:50:15 INFO - no previously-included directories found matching 'build' 06:50:15 INFO - no previously-included directories found matching 'dist' 06:50:15 INFO - no previously-included directories found matching '.git*' 06:50:15 INFO - Successfully installed jsonschema functools32 06:50:15 INFO - Cleaning up... 06:50:15 INFO - Return code: 0 06:50:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:15 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 0x7fd75c7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d82240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, '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': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', '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 06:50:15 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 06:50:15 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 06:50:15 INFO - Using env: {'DISPLAY': ':0', 06:50:15 INFO - 'HOME': '/home/cltbld', 06:50:15 INFO - 'LANG': 'en_US.UTF-8', 06:50:15 INFO - 'LANGUAGE': 'en_US:en', 06:50:15 INFO - 'LOGNAME': 'cltbld', 06:50:15 INFO - 'MAIL': '/var/mail/cltbld', 06:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:15 INFO - 'MOZ_NO_REMOTE': '1', 06:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:15 INFO - 'NO_EM_RESTART': '1', 06:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:15 INFO - 'PWD': '/builds/slave/test', 06:50:15 INFO - 'SHELL': '/bin/bash', 06:50:15 INFO - 'SHLVL': '1', 06:50:15 INFO - 'TERM': 'linux', 06:50:15 INFO - 'TMOUT': '86400', 06:50:15 INFO - 'USER': 'cltbld', 06:50:15 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:15 INFO - '_': '/tools/buildbot/bin/python'} 06:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:16 INFO - Downloading/unpacking flake8 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:17 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 06:50:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:17 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 06:50:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:17 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 06:50:18 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 06:50:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:18 INFO - no previously-included directories found matching 'docs/_build' 06:50:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:18 INFO - Running setup.py install for pep8 06:50:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:18 INFO - no previously-included directories found matching 'docs/_build' 06:50:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:18 INFO - Cleaning up... 06:50:18 INFO - Return code: 0 06:50:18 INFO - Running post-action listener: _resource_record_post_action 06:50:18 INFO - Running post-action listener: _start_resource_monitoring 06:50:18 INFO - Starting resource monitoring. 06:50:18 INFO - ##### 06:50:18 INFO - ##### Running install step. 06:50:18 INFO - ##### 06:50:18 INFO - Running pre-action listener: _resource_record_pre_action 06:50:18 INFO - Running main action method: install 06:50:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:18 INFO - Reading from file tmpfile_stdout 06:50:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:18 INFO - Reading from file tmpfile_stdout 06:50:18 INFO - Output received: 06:50:18 INFO - Usage: mozinstall [options] installer 06:50:18 INFO - Options: 06:50:18 INFO - -h, --help show this help message and exit 06:50:18 INFO - -d DEST, --destination=DEST 06:50:18 INFO - Directory to install application into. [default: 06:50:18 INFO - "/builds/slave/test"] 06:50:18 INFO - --app=APP Application being installed. [default: firefox] 06:50:18 INFO - mkdir: /builds/slave/test/build/application 06:50:18 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'] 06:50:18 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 06:50:34 INFO - Reading from file tmpfile_stdout 06:50:34 INFO - Output received: 06:50:34 INFO - /builds/slave/test/build/application/firefox/firefox 06:50:34 INFO - Running post-action listener: _resource_record_post_action 06:50:34 INFO - ##### 06:50:34 INFO - ##### Running run-tests step. 06:50:34 INFO - ##### 06:50:34 INFO - Running pre-action listener: _resource_record_pre_action 06:50:34 INFO - Running main action method: run_tests 06:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:34 INFO - Python 2.7.3 06:50:34 INFO - Return code: 0 06:50:34 INFO - grabbing minidump binary from tooltool 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 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 0x1e110b0>, '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 0x1e11fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e12440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:34 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 06:50:34 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 06:50:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:34 INFO - Return code: 0 06:50:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:50:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:50:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:50:35 INFO - Return code: 0 06:50:35 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/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 06:50:35 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/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 06:50:35 INFO - Using env: {'DISPLAY': ':0', 06:50:35 INFO - 'HOME': '/home/cltbld', 06:50:35 INFO - 'LANG': 'en_US.UTF-8', 06:50:35 INFO - 'LANGUAGE': 'en_US:en', 06:50:35 INFO - 'LOGNAME': 'cltbld', 06:50:35 INFO - 'MAIL': '/var/mail/cltbld', 06:50:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:35 INFO - 'MOZ_NO_REMOTE': '1', 06:50:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:35 INFO - 'NO_EM_RESTART': '1', 06:50:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:35 INFO - 'PWD': '/builds/slave/test', 06:50:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:35 INFO - 'SHELL': '/bin/bash', 06:50:35 INFO - 'SHLVL': '1', 06:50:35 INFO - 'TERM': 'linux', 06:50:35 INFO - 'TMOUT': '86400', 06:50:35 INFO - 'USER': 'cltbld', 06:50:35 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951', 06:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:35 INFO - '_': '/tools/buildbot/bin/python'} 06:50:35 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/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 06:50:35 INFO - mozversion INFO | application_buildid: 20151218054455 06:50:35 INFO - mozversion INFO | application_changeset: 5e54bf9610922270015d0c3ba3e9dadcb674179d 06:50:35 INFO - mozversion INFO | application_display_name: Nightly 06:50:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:35 INFO - mozversion INFO | application_name: Firefox 06:50:35 INFO - mozversion INFO | application_remotingname: firefox 06:50:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 06:50:35 INFO - mozversion INFO | application_vendor: Mozilla 06:50:35 INFO - mozversion INFO | application_version: 46.0a1 06:50:35 INFO - mozversion INFO | platform_buildid: 20151218054455 06:50:35 INFO - mozversion INFO | platform_changeset: 5e54bf9610922270015d0c3ba3e9dadcb674179d 06:50:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 06:50:35 INFO - mozversion INFO | platform_version: 46.0a1 06:50:35 INFO - 2015-12-18 06:50:35,551 DEBUG : using testdate: 1450450235 06:50:35 INFO - 2015-12-18 06:50:35,551 DEBUG : actual date: 1450450235 06:50:35 INFO - 2015-12-18 06:50:35,673 INFO : starting webserver on 'localhost:33548' 06:50:35 INFO - 2015-12-18 06:50:35,674 INFO : Starting test suite talos-linux64-ix-014 06:50:35 INFO - 2015-12-18 06:50:35,675 INFO : Starting test dromaeo_css 06:50:35 INFO - 2015-12-18 06:50:35,675 DEBUG : operating with platform_type : linux_ 06:50:35 INFO - 2015-12-18 06:50:35,675 INFO : Initialising browser for dromaeo_css test... 06:50:35 INFO - 2015-12-18 06:50:35,692 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_08FuV/profile http://localhost:33548/getInfo.html 06:50:40 INFO - 2015-12-18 06:50:40,081 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:50:40 INFO - 2015-12-18 06:50:40,081 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:50:40 INFO - 2015-12-18 06:50:40,082 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:50:40 INFO - 2015-12-18 06:50:40,082 DEBUG : BROWSER_OUTPUT: __metrics 06:50:40 INFO - 2015-12-18 06:50:40,184 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] 06:50:40 INFO - 2015-12-18 06:50:40,252 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] 06:50:41 INFO - 2015-12-18 06:50:41,513 INFO : Browser initialized. 06:50:41 INFO - 2015-12-18 06:50:41,514 INFO : Running cycle 1/1 for dromaeo_css test... 06:50:41 INFO - 2015-12-18 06:50:41,514 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_08FuV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:50:53 INFO - 2015-12-18 06:50:53,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 149168128 06:50:53 INFO - 2015-12-18 06:50:53,506 DEBUG : BROWSER_OUTPUT: 06:51:44 INFO - 2015-12-18 06:51:44,925 DEBUG : BROWSER_OUTPUT: 1450450304921 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] 06:53:57 INFO - 2015-12-18 06:53:57,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33548/tests/dromaeo/cssquery-ext.html) 06:53:58 INFO - 2015-12-18 06:53:58,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 261525504 06:53:58 INFO - 2015-12-18 06:53:58,421 DEBUG : BROWSER_OUTPUT: 06:57:00 INFO - 2015-12-18 06:57:00,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-ext.html (next: http://localhost:33548/tests/dromaeo/cssquery-jquery.html) 06:57:01 INFO - 2015-12-18 06:57:01,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 225079296 06:57:01 INFO - 2015-12-18 06:57:01,565 DEBUG : BROWSER_OUTPUT: 07:00:03 INFO - 2015-12-18 07:00:03,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33548/tests/dromaeo/cssquery-mootools.html) 07:00:04 INFO - 2015-12-18 07:00:04,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 227151872 07:00:04 INFO - 2015-12-18 07:00:04,068 DEBUG : BROWSER_OUTPUT: 07:03:06 INFO - 2015-12-18 07:03:06,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33548/tests/dromaeo/cssquery-prototype.html) 07:03:06 INFO - 2015-12-18 07:03:06,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 207822848 07:03:06 INFO - 2015-12-18 07:03:06,610 DEBUG : BROWSER_OUTPUT: 07:06:09 INFO - 2015-12-18 07:06:09,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33548/tests/dromaeo/cssquery-yui.html) 07:06:09 INFO - 2015-12-18 07:06:09,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 211419136 07:06:09 INFO - 2015-12-18 07:06:09,998 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-yui.html (next: http://localhost:33548/tests/dromaeo/cssquery-dojo.html) 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 255000576 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.4609605030964;2719.6600424946882;2727.7675953994517;2730.194592595184;2734.7128551502105;4510.526394728556;4622.514635963226;4668.649851261161;4724.126036683216;4724.31497432872;4542.15970045541;4599.88500287493;4616.192166370888;4633.698809577375;4648.4654264759565;4120.237756015132;4293.613574778269;4314.266574682311;4373.037931655047;4421.845235416761;4170.895727606804;4330.7401555906745;4334.804933777972;4381.605655491006;4392.538783427742;4201.054762678373;4242.575742425764;4245.957540424587;4306.849260275907;4326.5673432656795;4355.368471571636;4388.319810429389;4392.89017774555;4401.405810215644;4441.800118994653;4372.366006928977;4380;4383.978080109579;4395.7142785718825;4414.183376075436;4397.47230332359;4523.9321410178545;4538.478075021382;4600.5629465200755;4743.644226682978;5073.162928116893;5074.67014644047;5074.695518268915;5075.390953085616;5115.309433226504;5092.79628814847;5098.847034588968;5100.7449627518845;5101;5149.819756308511;4544.227481328182;4653.697509661861;4658.836940707059;4696.2486002239475;4824.903501930012;5214.661047031931;5240.816571419982;5245.947540524622;5248.265242866002;5256.579473642099;5003.699778013258;5009.24861270805;5014.724190169502;5015.82444614444;5050.72221027847;4828.686135401188;4956.529129732669;4957.206846904478;4990.3762029746285;5134.435212126663;5074.771635276422;5078.314427552307;5079.4412614612365;5081.9745901271;5137.845864624067;5040.647154699209;5043.167877300278;5043.773030213649;5045.571126454219;5047.798088076436;4079.3676980068135;4128.545859955402;4177.6866734995;4181.560936101726;4237.449131612871;3712.9628703712615;3720.1257704439436;3743.21392507571;3761.1161377076364;3768.057985503624;4327.718698284664;4358.585934336233;4360.520342762294;4397.670174736908;4407.625351845065;4812.398450193726;4931.284963680247;4936.90126197474;4958.380202474691;5062.645614807002;4355.7822108894425;4364.5635436456105;4375.387445757533;4383.890402739957;4407.7796110195;4540.114677637829;4542.523035081335;4547.136044151667;4556.749378784199;4591.1965406053805;4604.838830641045;4673.556012178838;4727.7163370197895;4731.692439991527;4807.206810876236;5105.591552675852;5114.9232761507865;5116.692998420107;5124.180131178993;5133.8716532087;4852.587530059985;4859.2954021667365;4865.440474345354;4868.099401610713;4885.047415754036;4781.641376896816;4888.902221955612;4898.510148985073;4902.558769710743;5081.314022606901;4994.625403094709;4997.200447928314;5005.124103281838;5007.749612519432;5036.748162591783;4914.410270767531;4920.950790492049;4922.556969872729;4922.704637721748;4938.9259161111895;4719.009008108198;4799.5680388763785;4799.736014519235;4836.322914792002;4953.504649535162;4849.418069831501;4849.80600775965;4857.53853383928;4882.292067650242;4887.169181239126;4964.35463389757;4971.552560269593;4975.5522003019905;4980.5019498049905;5013.197888337849;4694.647901407477;4816.662833601755;4818.180909245367;4886.975565122151;4937.9012419752125 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.869135753098;566.6458463460337;567.4183961439524;575.9366469688331;594.6907608043817;27154.456910861772;35906;36193.81903090487;36204;36208;40238.195236095264;40833.795831020805;41053.17893642125;41099;41114;7052.788416347492;7121.038659780941;7783.844323113549;8060.274575288223;8068.1528439513595;9755.122039016487;9958.302918795687;9991.100800927916;9996;9997.400155990628;9593.568289426958;9681.757956051084;9691.903080969207;9701.223902087851;9707.563159657797;7298.525595836254;7415.962920185419;9666.371685840433;9925.801483970352;10165.59337626494;9852.950735246279;10026.19790416765;10032.648857290033;10034.147097496721;10043.397396156253;37714;38052;38232.42651360232;38243.808780955915;38318.80840595807;2778.1108845984722;2837.333226691726;3360.277540328841;3496.2957093617547;3499.5275637788827;28724.856375717987;28776;28887.133385998455;28925.13224603244;29677;3043.1022848259818;3060.265536271279;3067.0952069139657;3077.830719310437;3164;215701;215766;216192;216435;217461.99999999843;49270.26094608584;50401.49598504041;50435.22606256618;50460.74769626202;53086;46589;46649;46673;46781;46809.531904680516;12505.874941250653;12713.809292860615;12747.36263186837;12774.23354598727;12779;9832.803343933081;9904.257180711475;9906.702798916043;10010.399376037461;10049.799004020026;17009.744853827204;17536.91231543834;17539.73690394645;17577.560560986076;17593;7206.675699593531;7262.419006479469;7370.262973702587;7473.925260747432;7496.587687677121;792.7066985215507;814.2997022560593;849.4181485682204;970.3213440747546;1003.9458568503188;26300.342491437867;26501.602475962874;26688.866555667097;26700.866495667786;26768.59847102295;926.1942110364026;950.9144177024101;993.0714781679009;1039.2309690828884;1068.086785798147;12108.576199832964;12520.186187897758;12537.247765134121;12559.686007849878;12609.87390126087;264645;267340;269036;270627;270985;43227.67723227652;43312.3503147453;43454;43509.34735978963;43550.56449435465;1211.4245733276623;1232.2606436138246;1240.6402143378318;1244.0918129765141;1247.4822948476462;22692;23144;23460.413489662213;25973.350666233495;26870.462590748466;36152.27695446129;36665;36754.26491470209;36759.448608271436;36802.26395472129;157729;158947;159501;159512;159689;24314.270571882873;24834.627480588166;27274.590881137196;28779.856100719364;29033.85483072571;33821.66178338185;34494.48258276178;34499.65500345065;34538.654613453546;34819.47770783491;28929.710702893542;29611.259718507208;29968.550471742506;32330.676693232766;32447.351052978334;25806.225813225632;31008;32326.83836580802;32598.837005814818;33699.15752106119;30424.239394015327;30626.234344140685;30750;30782.692173077983;32416.513752293264;28096.157115286573;28932.764618929526;29487.115386538437;29565;29599.112026639235;22986.885065574566;31619.84190079035;32854.342913141125;32896.83551582227;33126 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.3346739987425;335.3895909444811;336.4079220571793;338.0955942852868;338.4246780473196;12101.757964840697;12547.937260313709;15120.470783522578;15299;15694.215289235535;12303.63089107326;14500.564983050499;14738.115713057225;15152.54542363728;15158.621034474143;4476.776161191944;4765.3566768486335;4869.245266983615;4910.582600478946;5011.423686276088;4941.752912354368;4979.60163186946;4980.0288943656005;4981.651284410093;4982.850514484553;4747.145513807513;4926.11329960607;4930;4957;4958.504149585049;4946.678465899723;4970.6520543561965;4978.751062446863;4981.078500477387;4981.72600506972;4306.7631280279575;4436.755978421185;4444.177827101997;4446.555344465528;4446.822127114911;18950.43148705541;18952.5261868453;19539.706904396444;19819.10814013373;19886.502837429034;1871.6256748650324;1893.943181704551;1947.6396866579587;1955.8728682635583;2015.939521814348;12436.440360183722;12441.688957776038;12450.190737602026;12523.749525009449;13081.41133648988;1723.1987125986477;1744.9040302783342;1744.9127543622767;1774.1838754173095;1806.756087928139;52870.735646321904;54453.45546544524;55697.88604227933;55870.72064639691;56165.71917140429;9261.67584134552;9379.24966002718;9510.09654082861;9544.236461083097;9631.277654175965;10175.44035078063;10712.732181695364;11036.227464077598;12049.337286449154;12051.939740301243;6691.397774200345;6722.126123603998;6780.254172041072;6822.11312529368;6824.556403833735;6410.871782564416;6427.393151712072;6436.292007879129;6497.220333560003;6508.3491650835485;5653.745581448845;5713.428657134336;5716.42835716425;5716.485516303469;5787.450192231731;1667.1580851669828;1678.127373765635;1691.687037897993;1693.8052124005897;1694.7203711387483;365.42445648103813;368.3094198378041;371.2445174070807;381.07969254250673;820.885076089348;8635.309175265964;9208.171264586219;9363.62545498186;9540.809183816285;9868.062534059252;381.18806941215587;746.2127455534355;853.9231469167805;886.0607755778766;912.6896855069308;7698.152185248342;8089.595520223966;8593.011803642661;8659.740207793777;8749.781255468664;437759;445323;458203;459730;460819;55685.44314556884;55823.441765581825;65024.674876625315;65587;70487.64756176186;416.07008336368193;420.130330216449;425.4277996095247;429.33024481807854;430.9870703878889;9090.545472726206;9219.308551858503;9245.121713437213;9450.196733277473;9644.9035509644;34601.48097778485;35247.999999998974;35898.46152307665;36140.73507427228;36602.26795464129;47155.76422117867;48054.5194548064;48190;49713.75143124406;50780.746096269286;8471.534065626449;8693.30453563726;8773.29813614922;8775.210231079234;9307.72076837696;16163.191840408168;16177.272022758769;16485.58786030359;16600.916995414944;16912.32350705958;13554.457821687021;13860.376283067084;13958.930205348908;14051;14118;13172.341382931007;13212.339383031001;13625.523106691218;13782.93108534451;14159.858401415853;13339.66650833737;13593.252371119683;13612.183269003892;13623.250721210032;14271.57185284443;8064.637091331021;8082.838343232985;8094.554799486084;8105.392095592736;8813.735587932373;13312.201267923956;13369.732605348034;13619.455221791413;13855.584332470042;13949.721005580035 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1231.7721221574004;1579.076240399366;1653.3717187468765;1655.3957805401033;1699.736540836171;6161.3530579289145;6928.099347084878;6976.1628604567395;7034.683439245234;7066.611336376497;6965.233824279325;7136.322049405311;7191.173015103264;7191.856162876752;7197.7480788172425;1699.983000170001;1728.6456276463357;1957.4812674641232;1992.7110568967491;2026.0275067967384;1993.9202431902706;1997.071361816755;1998.4004798560375;2005.759308882936;2006.388051644248;1964.3419454482766;1970.0543739005286;2025.5948810238012;2027.8681885677383;2032.369965310751;1981.9207231710714;2002.1490866381803;2010.829079528242;2022.413500084981;2022.7067075274076;2060.732104826378;2076.688496725488;2081.198738485679;2085.0304608357037;2086.019570801736;7144.749933752294;7171.89242161368;7213.062301900719;7223.494355395124;7234.240404757477;4080;4151.543330233671;4158.521769996459;4165.562615925345;4168.541460439349;2522.5081109183716;2622.6721659792524;2637.907673231447;2643.41844794145;2645.1403293929357;848.1349023995551;855.9400841941067;861.8276344731016;862.0431321233426;883.6421249394006;9310.115539023782;9318.25453963688;9339.066093390607;9383.718488445289;9387.342885997983;3687.723420743455;3776.37689781183;3805.6384643458828;3809.29528037314;3814.4659747635355;8023.277904988462;8025.719099831478;8041.678332866737;8055.556944367999;8074.434789564674;4075.38869169621;4105.137921036616;4121.711480196357;4124.237016151961;4136.462259906193;3724.162063535737;3737.4020156774786;3761.4169803680475;3763.7365384423374;3766.1714422826935;2893.8842446302333;2933.8093023953375;3275.5414242006136;3288.0629020729457;3372.3423932332958;1055.8152323343384;1063.6330465989222;1071.689210129054;1072.6674730833467;1078.4338222433284;924.4314746430897;925.4447331600985;985.2512090811035;1071.1537885070863;1172.9178957472895;6530.706118224692;6564.409203171737;6570.441512471398;6593;6601.570897891622;1111.6720567432626;1131.140333346646;1138.5901075612774;1146.541383446628;1158.9478473468714;5161;5185.792568297301;5211.270422140903;5217.060929032735;5225.529702326809;8184.918150818535;8378.748637540884;8382.036065852504;8445.451045682134;8447.535385553854;8316.085230624627;8391.958040209882;8393.244607985189;8396.538190399464;8398.160183981552;6595.142631457879;6679.666016699242;6721.630310332978;6734.0572319875255;6828.829279267959;6737.9556168793915;6791.762288320083;6792.966035169792;6804.285550017375;6804.55770374924;7005.824854378681;7417.8887316689215;7511.887321690069;7530.811729706801;7714.1128770192145;7590.392768578611;7686.346660533917;7752.26353496417;7813.14055453911;7927.088384835818;5850.180974663465;5857.121431785095;5916.615419997686;5917.467427931507;5938.524918006636;5863.413658634103;6083.361247069171;6095.481884039907;6528.314526974599;6716.1604799400075;6312.779052733133;6372.299047104722;6436.549441539235;6465.127207827071;6554.4756419487285;6342.809715708536;6357.90463143044;6432.6462044588;6436.6459844707115;6462.030695395728;6122.846928826815;6239.656818875005;6247.125402443752;6297.842553936188;6332.208473940757;5967.91048134287;6018.699065046818;6019.458248757633;6019.72911219005;6030.03519436888;5683.8010669626365;5828.795992140254;5854.9121763174435;5872.0898260769645;5884.117382392676 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.53209099395457;291.699549464052;294.5008211082214;298.49703250023714;301.08770425610396;5333.413324534303;5376.838694839156;5399.379071406789;5399.62202645815;5411.0530657135;5279.208118782185;5280.603954703403;5289.867753306169;5290.656107353019;5309.150535914255;4102.692298077641;4106.650934670557;4107.322291821846;4108.794560271975;4112.239235741383;3950.0519875229884;4055.2700513907484;4117.21772863155;4118.732282401635;4122.628963393294;3966.266240745457;4008.739431936929;4020.5376381716037;4037.5962403759536;4050.2911990401562;4111.938320925188;4116.670666346715;4123.154753275571;4124.072083781125;4124.8762537123785;3613.5663720353464;3616.801075940822;3622.040159357746;3624.257027309395;3628.4194528875255;4896.681715688469;5045.974770126162;5065.974670126662;5175.611829112831;5181.844544663666;4688.320193571947;4688.624910007191;4695.67130300879;4704.223803072489;4708.105459962596;5636.379998200195;5638.295213098363;5642.238297829823;5645.604807663465;5652.378238393773;3802.049487628093;3866.1881004988986;3898.5516665583536;3910.1202229498135;3911.3350730375905;5910.793122240744;5911.793087241926;5918.141869428909;5925.614835035709;5928.140419639129;3951.920961580752;3951.92096158081;3956.604339566078;3958.6041395860184;3959.3269144245546;3915.980420097881;4012.3981402789814;4019.1157945252;4022.557518672944;4023.376376661622;4656.464506581787;4692.343071969859;4714.457837348748;4717.268823332389;4717.457492388351;5603.495685388253;5609.859753506195;5611.6352437091455;5615.606907516435;5623.971880140655;1441.891858110646;1461.8976671632884;1463.4219483304034;1463.677990842013;1464.1361596658023;994.5226291380178;994.855745916838;994.9005099489993;998.0368943969105;1022.2844009193594;4951.925721114186;4958.826441074545;4959.752012399365;4961.454240033666;4965.726885021286;5838.883222335529;5839.474447299764;5840.88318233633;5845;5846.41535846412;4960.330355402047;4961.3798275215595;4964.404271487372;4967.279744437036;4970.3538539990295;3071.416430878126;3109.284864481182;3122.7814053016073;3140.8586613602442;3142.528620706912;5529.087700529448;5534.612577119644;5535.944640553543;5537.556995440355;5540.445955404427;5976.491998180117;5991.730372133265;5995.2206213192;5995.430434108753;6008.4592386684535;5518.696471694096;5523.4200408956485;5527.613067085265;5530.806421775219;5533.22534845122;5657.971710141423;5826.475617194473;5827.562932779973;5830.47525722687;5832;5680.261565996394;5681.715914204356;5689.34572524165;5694.088945768657;5697.772089116389;5523.199136125159;5524.558035357081;5526.972365138309;5530.778768849201;5537.335519737658;4006.2187873364414;4087.5503694592976;4093.8771836844944;4096.938545921754;4100.302948498822;5568.805091821767;5759.683217422914;5817.0983497557945;5819.738111784895;5822.301323841166;5489.58828087887;5630.60585758993;5645.266115404971;5648.71756412186;5650.57620678459;5623.606347555632;5625.887482250414;5629.408912064338;5632.971835140798;5633.577481688972;5377.2740680009265;5499.312585926759;5504.422035686195;5507.394186639546;5517.586181036358;5671.801486948102;5678.063119585222;5678.14827775837;5681.375048744552;5686.715664216856;5535.197396377423;5536.363318218457;5542.944570554243;5543.584231182596;5547.5007249347755 07:09:12 INFO - 2015-12-18 07:09:12,957 DEBUG : BROWSER_OUTPUT: |5;yui.html;664.6743095883015;694.1358009278449;718.4755128756008;742.302235898256;749.1459735901074;10878.891211087886;11134.16493762968;11142.33146011239;11176.441177941091;12708.872911270884;12568.497260109607;12608.369581520934;12639;12671.809922851164;12681.556145534909;633.7908490198223;642.6882961763564;793.2662287384176;794.1819925476753;807.168616325186;795.8010497375656;796.4862663581986;803.441608082383;803.4616806739499;803.9959800200991;831.9292860106898;839.8740188971673;839.9580020998956;840.0381563110235;840.1262686805745;644.8387903024244;655.1908393134476;815.0463957170125;831.6631764135474;832.7793134819217;605.2434456928839;610.4597431273311;610.5176910240905;610.6732897899647;610.6885488400903;11671.649850504498;11908.34504102274;11935.403229838474;11941.10441716866;11945.343006134659;11115.666530004113;11181.273217240854;11187.384693841836;11674.474648640831;12137.271763694207;9047.004829468753;9068.093190680946;9214.723558293263;9359.625614975394;9402.670906518308;3159.0680749179046;3212.646608873022;3214.8874789382257;3249.545063691085;3251.4472539668313;41433;41565;41576.1684766306;41732.79133604313;41750.1649967002;9652.435131617345;9701.07839755222;9822.312438129262;9828.361156524803;9877.111060004634;17480.300787968594;17647.73528397075;17663.82336176622;17692.646147076986;17719.557011074827;6644.435223006002;6684.364985326386;6733.8653226935185;6736.8989465158065;6842.6578671066245;3364.6467120951947;3418.8461519231696;3459.9481007784902;3536.664016918389;3572.9523242546325;2543.4658721668657;2561.8334808237405;2573.5110329037425;2573.5238980788613;2574.472233192191;455.92933095370273;457.71621594611554;464.1969392950148;470.7834396177728;471.51198509542456;435.40132318062666;444.02314907204277;549.5027000564495;579.6753817862011;580.9302883653988;6436.871262574722;6492.058651495507;7403.889416587447;7646;7827.960860195776;481.53531841772855;533.9385970613351;569.3026043097173;572.1046562130252;577.0910815465659;3399.3711163434846;3466.4107101792756;3496.6852983231634;3525.7355698322726;3737.8691745788765;49157;49766.253506197434;49829.75085124551;49912.251316230286;50193.24710129351;44225;44251.557484425386;44563.777181114536;44657.330140047925;44809.775951120035;39590.406143907865;39872.60127398747;40333.77329813608;41010.79494602508;41155;7358.227386124594;7446.664900079401;7470.887936680845;7489.21363256872;7503.212162723054;31395.68604314019;31399.21501962469;31580.368392632477;31750.364992700477;31761.841190793897;35421.64578354183;35836.462453063745;38298.617013829506;39186.4122038164;39577.802110990415;9227.76930576741;9346.859797103185;9470.14768670823;10026.92998204662;10187.796244075225;10345.327553709287;10454.895451045391;10650.520726567169;10903.83644245321;11014.735082035791;9548.952255238679;9631.951840240754;9733.902660973583;10094.343867648578;10419.114375277883;9823;9957.352772069793;10026.899731002597;10555.525001374803;10848.349099054081;8768.868466973128;9137.08629137081;9290.16388525036;10023.198144148304;10384.169266458815;8365.330773538224;8424.663013479392;8555.401121921406;8612.354073444392;8978.86531702012;8171.673133074611;8316.501009939422;8358.23270011885;8691.304695624209;8800.779980500283 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,942 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451352950__endTimestamp 07:09:12 INFO - 2015-12-18 07:09:12,958 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4655.16 Median:4799.74 stddev:487.49 (10.2%) stddev-sans-first:462.36 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: Values: 2629.5 2719.7 2727.8 2730.2 2734.7 4510.5 4622.5 4668.6 4724.1 4724.3 4542.2 4599.9 4616.2 4633.7 4648.5 4120.2 4293.6 4314.3 4373.0 4421.8 4170.9 4330.7 4334.8 4381.6 4392.5 4201.1 4242.6 4246.0 4306.8 4326.6 4355.4 4388.3 4392.9 4401.4 4441.8 4372.4 4380.0 4384.0 4395.7 4414.2 4397.5 4523.9 4538.5 4600.6 4743.6 5073.2 5074.7 5074.7 5075.4 5115.3 5092.8 5098.8 5100.7 5101.0 5149.8 4544.2 4653.7 4658.8 4696.2 4824.9 5214.7 5240.8 5245.9 5248.3 5256.6 5003.7 5009.2 5014.7 5015.8 5050.7 4828.7 4956.5 4957.2 4990.4 5134.4 5074.8 5078.3 5079.4 5082.0 5137.8 5040.6 5043.2 5043.8 5045.6 5047.8 4079.4 4128.5 4177.7 4181.6 4237.4 3713.0 3720.1 3743.2 3761.1 3768.1 4327.7 4358.6 4360.5 4397.7 4407.6 4812.4 4931.3 4936.9 4958.4 5062.6 4355.8 4364.6 4375.4 4383.9 4407.8 4540.1 4542.5 4547.1 4556.7 4591.2 4604.8 4673.6 4727.7 4731.7 4807.2 5105.6 5114.9 5116.7 5124.2 5133.9 4852.6 4859.3 4865.4 4868.1 4885.0 4781.6 4888.9 4898.5 4902.6 5081.3 4994.6 4997.2 5005.1 5007.7 5036.7 4914.4 4921.0 4922.6 4922.7 4938.9 4719.0 4799.6 4799.7 4836.3 4953.5 4849.4 4849.8 4857.5 4882.3 4887.2 4964.4 4971.6 4975.6 4980.5 5013.2 4694.6 4816.7 4818.2 4887.0 4937.9 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,959 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37349.69 Median:32373.60 stddev:56985.98 (176.0%) stddev-sans-first:57078.88 07:09:12 INFO - 2015-12-18 07:09:12,960 DEBUG : BROWSER_OUTPUT: Values: 556.9 566.6 567.4 575.9 594.7 27154.5 35906.0 36193.8 36204.0 36208.0 40238.2 40833.8 41053.2 41099.0 41114.0 7052.8 7121.0 7783.8 8060.3 8068.2 9755.1 9958.3 9991.1 9996.0 9997.4 9593.6 9681.8 9691.9 9701.2 9707.6 7298.5 7416.0 9666.4 9925.8 10165.6 9853.0 10026.2 10032.6 10034.1 10043.4 37714.0 38052.0 38232.4 38243.8 38318.8 2778.1 2837.3 3360.3 3496.3 3499.5 28724.9 28776.0 28887.1 28925.1 29677.0 3043.1 3060.3 3067.1 3077.8 3164.0 215701.0 215766.0 216192.0 216435.0 217462.0 49270.3 50401.5 50435.2 50460.7 53086.0 46589.0 46649.0 46673.0 46781.0 46809.5 12505.9 12713.8 12747.4 12774.2 12779.0 9832.8 9904.3 9906.7 10010.4 10049.8 17009.7 17536.9 17539.7 17577.6 17593.0 7206.7 7262.4 7370.3 7473.9 7496.6 792.7 814.3 849.4 970.3 1003.9 26300.3 26501.6 26688.9 26700.9 26768.6 926.2 950.9 993.1 1039.2 1068.1 12108.6 12520.2 12537.2 12559.7 12609.9 264645.0 267340.0 269036.0 270627.0 270985.0 43227.7 43312.4 43454.0 43509.3 43550.6 1211.4 1232.3 1240.6 1244.1 1247.5 22692.0 23144.0 23460.4 25973.4 26870.5 36152.3 36665.0 36754.3 36759.4 36802.3 157729.0 158947.0 159501.0 159512.0 159689.0 24314.3 24834.6 27274.6 28779.9 29033.9 33821.7 34494.5 34499.7 34538.7 34819.5 28929.7 29611.3 29968.6 32330.7 32447.4 25806.2 31008.0 32326.8 32598.8 33699.2 30424.2 30626.2 30750.0 30782.7 32416.5 28096.2 28932.8 29487.1 29565.0 29599.1 22986.9 31619.8 32854.3 32896.8 33126.0 07:09:12 INFO - 2015-12-18 07:09:12,960 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,961 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25035.67 Median:224884.91 stddev:73917.59 (32.9%) stddev-sans-first:74101.68 07:09:12 INFO - 2015-12-18 07:09:12,961 DEBUG : BROWSER_OUTPUT: Values: 334.3 335.4 336.4 338.1 338.4 12101.8 12547.9 15120.5 15299.0 15694.2 12303.6 14500.6 14738.1 15152.5 15158.6 4476.8 4765.4 4869.2 4910.6 5011.4 4941.8 4979.6 4980.0 4981.7 4982.9 4747.1 4926.1 4930.0 4957.0 4958.5 4946.7 4970.7 4978.8 4981.1 4981.7 4306.8 4436.8 4444.2 4446.6 4446.8 18950.4 18952.5 19539.7 19819.1 19886.5 1871.6 1893.9 1947.6 1955.9 2015.9 12436.4 12441.7 12450.2 12523.7 13081.4 1723.2 1744.9 1744.9 1774.2 1806.8 52870.7 54453.5 55697.9 55870.7 56165.7 9261.7 9379.2 9510.1 9544.2 9631.3 10175.4 10712.7 11036.2 12049.3 12051.9 6691.4 6722.1 6780.3 6822.1 6824.6 6410.9 6427.4 6436.3 6497.2 6508.3 5653.7 5713.4 5716.4 5716.5 5787.5 1667.2 1678.1 1691.7 1693.8 1694.7 365.4 368.3 371.2 381.1 820.9 8635.3 9208.2 9363.6 9540.8 9868.1 381.2 746.2 853.9 886.1 912.7 7698.2 8089.6 8593.0 8659.7 8749.8 437759.0 445323.0 458203.0 459730.0 460819.0 55685.4 55823.4 65024.7 65587.0 70487.6 416.1 420.1 425.4 429.3 431.0 9090.5 9219.3 9245.1 9450.2 9644.9 34601.5 35248.0 35898.5 36140.7 36602.3 47155.8 48054.5 48190.0 49713.8 50780.7 8471.5 8693.3 8773.3 8775.2 9307.7 16163.2 16177.3 16485.6 16600.9 16912.3 13554.5 13860.4 13958.9 14051.0 14118.0 13172.3 13212.3 13625.5 13782.9 14159.9 13339.7 13593.3 13612.2 13623.3 14271.6 8064.6 8082.8 8094.6 8105.4 8813.7 13312.2 13369.7 13619.5 13855.6 13949.7 07:09:12 INFO - 2015-12-18 07:09:12,961 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,961 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4889.20 Median:6019.59 stddev:2532.13 (42.1%) stddev-sans-first:2524.30 07:09:12 INFO - 2015-12-18 07:09:12,962 DEBUG : BROWSER_OUTPUT: Values: 1231.8 1579.1 1653.4 1655.4 1699.7 6161.4 6928.1 6976.2 7034.7 7066.6 6965.2 7136.3 7191.2 7191.9 7197.7 1700.0 1728.6 1957.5 1992.7 2026.0 1993.9 1997.1 1998.4 2005.8 2006.4 1964.3 1970.1 2025.6 2027.9 2032.4 1981.9 2002.1 2010.8 2022.4 2022.7 2060.7 2076.7 2081.2 2085.0 2086.0 7144.7 7171.9 7213.1 7223.5 7234.2 4080.0 4151.5 4158.5 4165.6 4168.5 2522.5 2622.7 2637.9 2643.4 2645.1 848.1 855.9 861.8 862.0 883.6 9310.1 9318.3 9339.1 9383.7 9387.3 3687.7 3776.4 3805.6 3809.3 3814.5 8023.3 8025.7 8041.7 8055.6 8074.4 4075.4 4105.1 4121.7 4124.2 4136.5 3724.2 3737.4 3761.4 3763.7 3766.2 2893.9 2933.8 3275.5 3288.1 3372.3 1055.8 1063.6 1071.7 1072.7 1078.4 924.4 925.4 985.3 1071.2 1172.9 6530.7 6564.4 6570.4 6593.0 6601.6 1111.7 1131.1 1138.6 1146.5 1158.9 5161.0 5185.8 5211.3 5217.1 5225.5 8184.9 8378.7 8382.0 8445.5 8447.5 8316.1 8392.0 8393.2 8396.5 8398.2 6595.1 6679.7 6721.6 6734.1 6828.8 6738.0 6791.8 6793.0 6804.3 6804.6 7005.8 7417.9 7511.9 7530.8 7714.1 7590.4 7686.3 7752.3 7813.1 7927.1 5850.2 5857.1 5916.6 5917.5 5938.5 5863.4 6083.4 6095.5 6528.3 6716.2 6312.8 6372.3 6436.5 6465.1 6554.5 6342.8 6357.9 6432.6 6436.6 6462.0 6122.8 6239.7 6247.1 6297.8 6332.2 5967.9 6018.7 6019.5 6019.7 6030.0 5683.8 5828.8 5854.9 5872.1 5884.1 07:09:12 INFO - 2015-12-18 07:09:12,962 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,962 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4654.83 Median:5321.28 stddev:1373.12 (25.8%) stddev-sans-first:1337.35 07:09:12 INFO - 2015-12-18 07:09:12,962 DEBUG : BROWSER_OUTPUT: Values: 291.5 291.7 294.5 298.5 301.1 5333.4 5376.8 5399.4 5399.6 5411.1 5279.2 5280.6 5289.9 5290.7 5309.2 4102.7 4106.7 4107.3 4108.8 4112.2 3950.1 4055.3 4117.2 4118.7 4122.6 3966.3 4008.7 4020.5 4037.6 4050.3 4111.9 4116.7 4123.2 4124.1 4124.9 3613.6 3616.8 3622.0 3624.3 3628.4 4896.7 5046.0 5066.0 5175.6 5181.8 4688.3 4688.6 4695.7 4704.2 4708.1 5636.4 5638.3 5642.2 5645.6 5652.4 3802.0 3866.2 3898.6 3910.1 3911.3 5910.8 5911.8 5918.1 5925.6 5928.1 3951.9 3951.9 3956.6 3958.6 3959.3 3916.0 4012.4 4019.1 4022.6 4023.4 4656.5 4692.3 4714.5 4717.3 4717.5 5603.5 5609.9 5611.6 5615.6 5624.0 1441.9 1461.9 1463.4 1463.7 1464.1 994.5 994.9 994.9 998.0 1022.3 4951.9 4958.8 4959.8 4961.5 4965.7 5838.9 5839.5 5840.9 5845.0 5846.4 4960.3 4961.4 4964.4 4967.3 4970.4 3071.4 3109.3 3122.8 3140.9 3142.5 5529.1 5534.6 5535.9 5537.6 5540.4 5976.5 5991.7 5995.2 5995.4 6008.5 5518.7 5523.4 5527.6 5530.8 5533.2 5658.0 5826.5 5827.6 5830.5 5832.0 5680.3 5681.7 5689.3 5694.1 5697.8 5523.2 5524.6 5527.0 5530.8 5537.3 4006.2 4087.6 4093.9 4096.9 4100.3 5568.8 5759.7 5817.1 5819.7 5822.3 5489.6 5630.6 5645.3 5648.7 5650.6 5623.6 5625.9 5629.4 5633.0 5633.6 5377.3 5499.3 5504.4 5507.4 5517.6 5671.8 5678.1 5678.1 5681.4 5686.7 5535.2 5536.4 5542.9 5543.6 5547.5 07:09:12 INFO - 2015-12-18 07:09:12,963 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2015-12-18 07:09:12,963 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12129.68 Median:476.52 stddev:13825.18 (2901.3%) stddev-sans-first:13837.15 07:09:12 INFO - 2015-12-18 07:09:12,964 DEBUG : BROWSER_OUTPUT: Values: 664.7 694.1 718.5 742.3 749.1 10878.9 11134.2 11142.3 11176.4 12708.9 12568.5 12608.4 12639.0 12671.8 12681.6 633.8 642.7 793.3 794.2 807.2 795.8 796.5 803.4 803.5 804.0 831.9 839.9 840.0 840.0 840.1 644.8 655.2 815.0 831.7 832.8 605.2 610.5 610.5 610.7 610.7 11671.6 11908.3 11935.4 11941.1 11945.3 11115.7 11181.3 11187.4 11674.5 12137.3 9047.0 9068.1 9214.7 9359.6 9402.7 3159.1 3212.6 3214.9 3249.5 3251.4 41433.0 41565.0 41576.2 41732.8 41750.2 9652.4 9701.1 9822.3 9828.4 9877.1 17480.3 17647.7 17663.8 17692.6 17719.6 6644.4 6684.4 6733.9 6736.9 6842.7 3364.6 3418.8 3459.9 3536.7 3573.0 2543.5 2561.8 2573.5 2573.5 2574.5 455.9 457.7 464.2 470.8 471.5 435.4 444.0 549.5 579.7 580.9 6436.9 6492.1 7403.9 7646.0 7828.0 481.5 533.9 569.3 572.1 577.1 3399.4 3466.4 3496.7 3525.7 3737.9 49157.0 49766.3 49829.8 49912.3 50193.2 44225.0 44251.6 44563.8 44657.3 44809.8 39590.4 39872.6 40333.8 41010.8 41155.0 7358.2 7446.7 7470.9 7489.2 7503.2 31395.7 31399.2 31580.4 31750.4 31761.8 35421.6 35836.5 38298.6 39186.4 39577.8 9227.8 9346.9 9470.1 10026.9 10187.8 10345.3 10454.9 10650.5 10903.8 11014.7 9549.0 9632.0 9733.9 10094.3 10419.1 9823.0 9957.4 10026.9 10555.5 10848.3 8768.9 9137.1 9290.2 10023.2 10384.2 8365.3 8424.7 8555.4 8612.4 8978.9 8171.7 8316.5 8358.2 8691.3 8800.8 07:09:12 INFO - 2015-12-18 07:09:12,964 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:09:12 INFO - 2015-12-18 07:09:12,964 DEBUG : BROWSER_OUTPUT: 07:09:13 INFO - 2015-12-18 07:09:13,729 INFO : Browser exited with error code: 0 07:09:13 INFO - 2015-12-18 07:09:13,750 INFO : Completed test dromaeo_css (00:18:38) 07:09:13 INFO - 2015-12-18 07:09:13,750 INFO : Starting test kraken 07:09:13 INFO - 2015-12-18 07:09:13,751 DEBUG : operating with platform_type : linux_ 07:09:13 INFO - 2015-12-18 07:09:13,751 INFO : Initialising browser for kraken test... 07:09:13 INFO - 2015-12-18 07:09:13,757 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3y9PE/profile http://localhost:33548/getInfo.html 07:09:17 INFO - 2015-12-18 07:09:17,978 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:09:17 INFO - 2015-12-18 07:09:17,978 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:09:17 INFO - 2015-12-18 07:09:17,978 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:09:17 INFO - 2015-12-18 07:09:17,978 DEBUG : BROWSER_OUTPUT: __metrics 07:09:18 INFO - 2015-12-18 07:09:18,095 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:09:18 INFO - 2015-12-18 07:09:18,155 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:09:19 INFO - 2015-12-18 07:09:19,377 INFO : Browser initialized. 07:09:19 INFO - 2015-12-18 07:09:19,377 INFO : Running cycle 1/1 for kraken test... 07:09:19 INFO - 2015-12-18 07:09:19,378 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3y9PE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:09:31 INFO - 2015-12-18 07:09:31,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 149676032 07:09:31 INFO - 2015-12-18 07:09:31,356 DEBUG : BROWSER_OUTPUT: 07:09:33 INFO - 2015-12-18 07:09:33,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:34 INFO - 2015-12-18 07:09:34,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 184193024 07:09:34 INFO - 2015-12-18 07:09:34,539 DEBUG : BROWSER_OUTPUT: 07:09:37 INFO - 2015-12-18 07:09:37,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-dft) 07:09:37 INFO - 2015-12-18 07:09:37,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 174260224 07:09:37 INFO - 2015-12-18 07:09:37,810 DEBUG : BROWSER_OUTPUT: 07:09:40 INFO - 2015-12-18 07:09:40,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-fft) 07:09:41 INFO - 2015-12-18 07:09:41,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 161710080 07:09:41 INFO - 2015-12-18 07:09:41,363 DEBUG : BROWSER_OUTPUT: 07:09:43 INFO - 2015-12-18 07:09:43,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-oscillator) 07:09:43 INFO - 2015-12-18 07:09:43,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 162975744 07:09:43 INFO - 2015-12-18 07:09:43,989 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2015-12-18 07:09:46,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:46 INFO - 2015-12-18 07:09:46,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 164319232 07:09:46 INFO - 2015-12-18 07:09:46,788 DEBUG : BROWSER_OUTPUT: 07:09:49 INFO - 2015-12-18 07:09:49,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:50 INFO - 2015-12-18 07:09:50,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 164151296 07:09:50 INFO - 2015-12-18 07:09:50,315 DEBUG : BROWSER_OUTPUT: 07:09:53 INFO - 2015-12-18 07:09:53,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:54 INFO - 2015-12-18 07:09:54,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 166412288 07:09:54 INFO - 2015-12-18 07:09:54,328 DEBUG : BROWSER_OUTPUT: 07:09:57 INFO - 2015-12-18 07:09:57,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33548/tests/kraken/driver.html?testName=json-parse-financial) 07:09:57 INFO - 2015-12-18 07:09:57,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 165900288 07:09:57 INFO - 2015-12-18 07:09:57,751 DEBUG : BROWSER_OUTPUT: 07:09:59 INFO - 2015-12-18 07:09:59,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:00 INFO - 2015-12-18 07:10:00,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 174583808 07:10:00 INFO - 2015-12-18 07:10:00,098 DEBUG : BROWSER_OUTPUT: 07:10:01 INFO - 2015-12-18 07:10:01,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:02 INFO - 2015-12-18 07:10:02,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 171778048 07:10:02 INFO - 2015-12-18 07:10:02,542 DEBUG : BROWSER_OUTPUT: 07:10:04 INFO - 2015-12-18 07:10:04,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:05 INFO - 2015-12-18 07:10:05,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 185774080 07:10:05 INFO - 2015-12-18 07:10:05,266 DEBUG : BROWSER_OUTPUT: 07:10:07 INFO - 2015-12-18 07:10:07,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:08 INFO - 2015-12-18 07:10:08,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 190951424 07:10:08 INFO - 2015-12-18 07:10:08,392 DEBUG : BROWSER_OUTPUT: 07:10:10 INFO - 2015-12-18 07:10:10,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:11 INFO - 2015-12-18 07:10:11,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 189796352 07:10:11 INFO - 2015-12-18 07:10:11,548 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33548/tests/kraken/driver.html?testName=ai-astar) 07:10:13 INFO - 2015-12-18 07:10:13,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 247754752 07:10:13 INFO - 2015-12-18 07:10:13,562 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:13 INFO - 2015-12-18 07:10:13,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:13 INFO - 2015-12-18 07:10:13,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:13 INFO - 2015-12-18 07:10:13,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:13 INFO - 2015-12-18 07:10:13,565 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;106;112;113;113;102;112;112;103 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;153;166;135;155;154;129;167;129 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;160;161;160;159;160;160;163 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;78;92;74;72;72;116;94;72 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;135;93;94;93;135;94;94;130 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;147;148;147;148;147;147 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;70;71;72;71;81;71;69 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;69;68;68;68;67;67 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;93;83;85;86;85;84;83 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;117;129;147;115;127;121;129;119;127 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;149;149;150;148;135;150;147;148;134 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;76;71;70;70;71;70;69 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:10:13 INFO - 2015-12-18 07:10:13,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,992 07:10:13 INFO - 2015-12-18 07:10:13,567 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:10:13 INFO - 2015-12-18 07:10:13,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451413564__endTimestamp 07:10:13 INFO - 2015-12-18 07:10:13,567 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:4.42 (3.9%) stddev-sans-first:4.66 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 106.0 112.0 113.0 113.0 102.0 112.0 112.0 103.0 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:154.00 stddev:14.93 (9.7%) stddev-sans-first:15.64 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 153.0 166.0 135.0 155.0 154.0 129.0 167.0 129.0 07:10:13 INFO - 2015-12-18 07:10:13,570 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 160.0 161.0 160.0 159.0 160.0 160.0 163.0 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:14.83 (20.2%) stddev-sans-first:15.41 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 78.0 92.0 74.0 72.0 72.0 116.0 94.0 72.0 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:94.00 stddev:19.13 (20.3%) stddev-sans-first:19.81 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 135.0 93.0 94.0 93.0 135.0 94.0 94.0 130.0 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 147.0 148.0 147.0 148.0 147.0 147.0 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,571 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.00 stddev:3.31 (4.7%) stddev-sans-first:3.52 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 70.0 71.0 72.0 71.0 81.0 71.0 69.0 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 69.0 68.0 68.0 68.0 67.0 67.0 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,572 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.96 (3.5%) stddev-sans-first:3.04 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 93.0 83.0 85.0 86.0 85.0 84.0 83.0 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:9.29 (7.3%) stddev-sans-first:9.59 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: Values: 119.0 117.0 129.0 147.0 115.0 127.0 121.0 129.0 119.0 127.0 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:148.50 stddev:6.85 (4.6%) stddev-sans-first:6.35 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: Values: 135.0 149.0 149.0 150.0 148.0 135.0 150.0 147.0 148.0 134.0 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: 07:10:13 INFO - 2015-12-18 07:10:13,573 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:2.01 (2.9%) stddev-sans-first:2.12 07:10:13 INFO - 2015-12-18 07:10:13,574 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 76.0 71.0 70.0 70.0 71.0 70.0 69.0 07:10:13 INFO - 2015-12-18 07:10:13,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:13 INFO - 2015-12-18 07:10:13,574 DEBUG : BROWSER_OUTPUT: 07:10:14 INFO - 2015-12-18 07:10:14,537 INFO : Browser exited with error code: 0 07:10:14 INFO - 2015-12-18 07:10:14,589 INFO : Completed test kraken (00:01:00) 07:10:14 INFO - 2015-12-18 07:10:14,589 INFO : Starting test v8_7 07:10:14 INFO - 2015-12-18 07:10:14,589 DEBUG : operating with platform_type : linux_ 07:10:14 INFO - 2015-12-18 07:10:14,589 INFO : Initialising browser for v8_7 test... 07:10:14 INFO - 2015-12-18 07:10:14,595 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGzME3/profile http://localhost:33548/getInfo.html 07:10:19 INFO - 2015-12-18 07:10:19,118 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:10:19 INFO - 2015-12-18 07:10:19,118 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:10:19 INFO - 2015-12-18 07:10:19,118 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:10:19 INFO - 2015-12-18 07:10:19,118 DEBUG : BROWSER_OUTPUT: __metrics 07:10:19 INFO - 2015-12-18 07:10:19,239 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:10:19 INFO - 2015-12-18 07:10:19,295 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:10:19 ERROR - 2015-12-18 07:10:19,311 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 07:10:20 INFO - 2015-12-18 07:10:20,265 INFO : Browser initialized. 07:10:20 INFO - 2015-12-18 07:10:20,266 INFO : Running cycle 1/1 for v8_7 test... 07:10:20 INFO - 2015-12-18 07:10:20,266 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGzME3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:32 INFO - 2015-12-18 07:10:32,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 149860352 07:10:32 INFO - 2015-12-18 07:10:32,294 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33548/tests/v8_7/run.html (next: http://localhost:33548/tests/v8_7/run.html) 07:10:53 INFO - 2015-12-18 07:10:53,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 451837952 07:10:53 INFO - 2015-12-18 07:10:53,912 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,912 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:53 INFO - 2015-12-18 07:10:53,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:53 INFO - 2015-12-18 07:10:53,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:53 INFO - 2015-12-18 07:10:53,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:53 INFO - 2015-12-18 07:10:53,913 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7289500167729 07:10:53 INFO - 2015-12-18 07:10:53,913 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 07:10:53 INFO - 2015-12-18 07:10:53,913 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |8;Splay;609.0133982947625 07:10:53 INFO - 2015-12-18 07:10:53,914 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:10:53 INFO - 2015-12-18 07:10:53,915 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:53 INFO - 2015-12-18 07:10:53,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1450451453909__endTimestamp 07:10:53 INFO - 2015-12-18 07:10:53,915 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:53 INFO - 2015-12-18 07:10:53,915 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: Values: 167.7 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,916 DEBUG : BROWSER_OUTPUT: Values: 185.6 07:10:53 INFO - 2015-12-18 07:10:53,917 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,917 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,917 DEBUG : BROWSER_OUTPUT: Values: 278.4 07:10:53 INFO - 2015-12-18 07:10:53,917 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,917 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: Values: 5128.2 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: Values: 1982.2 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,918 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: Values: 782.5 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: Values: 11988.1 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: Values: 27081.1 07:10:53 INFO - 2015-12-18 07:10:53,919 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.01 Median:609.01 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: Values: 609.0 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:53 INFO - 2015-12-18 07:10:53,920 DEBUG : BROWSER_OUTPUT: 07:10:54 INFO - 2015-12-18 07:10:54,801 INFO : Browser exited with error code: 0 07:10:54 INFO - 2015-12-18 07:10:54,813 INFO : Completed test v8_7 (00:00:40) 07:10:54 INFO - 2015-12-18 07:10:54,972 INFO : Completed test suite (00:20:19) 07:10:54 INFO - 2015-12-18 07:10:54,972 DEBUG : Working with test: dromaeo_css 07:10:54 INFO - 2015-12-18 07:10:54,972 DEBUG : Generating results file: dromaeo_css 07:10:54 INFO - 2015-12-18 07:10:54,973 DEBUG : Working with test: kraken 07:10:54 INFO - 2015-12-18 07:10:54,973 DEBUG : Generating results file: kraken 07:10:54 INFO - 2015-12-18 07:10:54,974 INFO : javascript benchmark 07:10:54 INFO - 2015-12-18 07:10:54,974 DEBUG : Working with test: v8_7 07:10:54 INFO - 2015-12-18 07:10:54,974 DEBUG : Generating results file: v8_7 07:10:54 INFO - 2015-12-18 07:10:54,974 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:55 INFO - 2015-12-18 07:10:55,032 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 07:10:55 INFO - 2015-12-18 07:10:55,032 DEBUG : process_Request line: dromaeo_css 6178.74 graph.html#tests=[[72,203,35]] 07:10:55 INFO - 2015-12-18 07:10:55,033 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:55 INFO - 2015-12-18 07:10:55,079 DEBUG : process_Request line: kraken 1520.40 graph.html#tests=[[232,203,35]] 07:10:55 INFO - 2015-12-18 07:10:55,079 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:55 INFO - 2015-12-18 07:10:55,121 DEBUG : process_Request line: v8_7 19841.28 graph.html#tests=[[230,203,35]] 07:10:55 INFO - 2015-12-18 07:10:55,122 INFO : javascript benchmark 07:10:55 INFO - 2015-12-18 07:10:55,126 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.4609605030964, 2719.6600424946882, 2727.7675953994517, 2730.194592595184, 2734.7128551502105, 4510.526394728556, 4622.514635963226, 4668.649851261161, 4724.126036683216, 4724.31497432872, 4542.15970045541, 4599.88500287493, 4616.192166370888, 4633.698809577375, 4648.4654264759565, 4120.237756015132, 4293.613574778269, 4314.266574682311, 4373.037931655047, 4421.845235416761, 4170.895727606804, 4330.7401555906745, 4334.804933777972, 4381.605655491006, 4392.538783427742, 4201.054762678373, 4242.575742425764, 4245.957540424587, 4306.849260275907, 4326.5673432656795, 4355.368471571636, 4388.319810429389, 4392.89017774555, 4401.405810215644, 4441.800118994653, 4372.366006928977, 4380.0, 4383.978080109579, 4395.7142785718825, 4414.183376075436, 4397.47230332359, 4523.9321410178545, 4538.478075021382, 4600.5629465200755, 4743.644226682978, 5073.162928116893, 5074.67014644047, 5074.695518268915, 5075.390953085616, 5115.309433226504, 5092.79628814847, 5098.847034588968, 5100.7449627518845, 5101.0, 5149.819756308511, 4544.227481328182, 4653.697509661861, 4658.836940707059, 4696.2486002239475, 4824.903501930012, 5214.661047031931, 5240.816571419982, 5245.947540524622, 5248.265242866002, 5256.579473642099, 5003.699778013258, 5009.24861270805, 5014.724190169502, 5015.82444614444, 5050.72221027847, 4828.686135401188, 4956.529129732669, 4957.206846904478, 4990.3762029746285, 5134.435212126663, 5074.771635276422, 5078.314427552307, 5079.4412614612365, 5081.9745901271, 5137.845864624067, 5040.647154699209, 5043.167877300278, 5043.773030213649, 5045.571126454219, 5047.798088076436, 4079.3676980068135, 4128.545859955402, 4177.6866734995, 4181.560936101726, 4237.449131612871, 3712.9628703712615, 3720.1257704439436, 3743.21392507571, 3761.1161377076364, 3768.057985503624, 4327.718698284664, 4358.585934336233, 4360.520342762294, 4397.670174736908, 4407.625351845065, 4812.398450193726, 4931.284963680247, 4936.90126197474, 4958.380202474691, 5062.645614807002, 4355.7822108894425, 4364.5635436456105, 4375.387445757533, 4383.890402739957, 4407.7796110195, 4540.114677637829, 4542.523035081335, 4547.136044151667, 4556.749378784199, 4591.1965406053805, 4604.838830641045, 4673.556012178838, 4727.7163370197895, 4731.692439991527, 4807.206810876236, 5105.591552675852, 5114.9232761507865, 5116.692998420107, 5124.180131178993, 5133.8716532087, 4852.587530059985, 4859.2954021667365, 4865.440474345354, 4868.099401610713, 4885.047415754036, 4781.641376896816, 4888.902221955612, 4898.510148985073, 4902.558769710743, 5081.314022606901, 4994.625403094709, 4997.200447928314, 5005.124103281838, 5007.749612519432, 5036.748162591783, 4914.410270767531, 4920.950790492049, 4922.556969872729, 4922.704637721748, 4938.9259161111895, 4719.009008108198, 4799.5680388763785, 4799.736014519235, 4836.322914792002, 4953.504649535162, 4849.418069831501, 4849.80600775965, 4857.53853383928, 4882.292067650242, 4887.169181239126, 4964.35463389757, 4971.552560269593, 4975.5522003019905, 4980.5019498049905, 5013.197888337849, 4694.647901407477, 4816.662833601755, 4818.180909245367, 4886.975565122151, 4937.9012419752125], "unit": "score", "name": "dojo.html", "value": 4624.934565562165}, {"lowerIsBetter": false, "replicates": [556.869135753098, 566.6458463460337, 567.4183961439524, 575.9366469688331, 594.6907608043817, 27154.456910861772, 35906.0, 36193.81903090487, 36204.0, 36208.0, 40238.195236095264, 40833.795831020805, 41053.17893642125, 41099.0, 41114.0, 7052.788416347492, 7121.038659780941, 7783.844323113549, 8060.274575288223, 8068.1528439513595, 9755.122039016487, 9958.302918795687, 9991.100800927916, 9996.0, 9997.400155990628, 9593.568289426958, 9681.757956051084, 9691.903080969207, 9701.223902087851, 9707.563159657797, 7298.525595836254, 7415.962920185419, 9666.371685840433, 9925.801483970352, 10165.59337626494, 9852.950735246279, 10026.19790416765, 10032.648857290033, 10034.147097496721, 10043.397396156253, 37714.0, 38052.0, 38232.42651360232, 38243.808780955915, 38318.80840595807, 2778.1108845984722, 2837.333226691726, 3360.277540328841, 3496.2957093617547, 3499.5275637788827, 28724.856375717987, 28776.0, 28887.133385998455, 28925.13224603244, 29677.0, 3043.1022848259818, 3060.265536271279, 3067.0952069139657, 3077.830719310437, 3164.0, 215701.0, 215766.0, 216192.0, 216435.0, 217461.99999999843, 49270.26094608584, 50401.49598504041, 50435.22606256618, 50460.74769626202, 53086.0, 46589.0, 46649.0, 46673.0, 46781.0, 46809.531904680516, 12505.874941250653, 12713.809292860615, 12747.36263186837, 12774.23354598727, 12779.0, 9832.803343933081, 9904.257180711475, 9906.702798916043, 10010.399376037461, 10049.799004020026, 17009.744853827204, 17536.91231543834, 17539.73690394645, 17577.560560986076, 17593.0, 7206.675699593531, 7262.419006479469, 7370.262973702587, 7473.925260747432, 7496.587687677121, 792.7066985215507, 814.2997022560593, 849.4181485682204, 970.3213440747546, 1003.9458568503188, 26300.342491437867, 26501.602475962874, 26688.866555667097, 26700.866495667786, 26768.59847102295, 926.1942110364026, 950.9144177024101, 993.0714781679009, 1039.2309690828884, 1068.086785798147, 12108.576199832964, 12520.186187897758, 12537.247765134121, 12559.686007849878, 12609.87390126087, 264645.0, 267340.0, 269036.0, 270627.0, 270985.0, 43227.67723227652, 43312.3503147453, 43454.0, 43509.34735978963, 43550.56449435465, 1211.4245733276623, 1232.2606436138246, 1240.6402143378318, 1244.0918129765141, 1247.4822948476462, 22692.0, 23144.0, 23460.413489662213, 25973.350666233495, 26870.462590748466, 36152.27695446129, 36665.0, 36754.26491470209, 36759.448608271436, 36802.26395472129, 157729.0, 158947.0, 159501.0, 159512.0, 159689.0, 24314.270571882873, 24834.627480588166, 27274.590881137196, 28779.856100719364, 29033.85483072571, 33821.66178338185, 34494.48258276178, 34499.65500345065, 34538.654613453546, 34819.47770783491, 28929.710702893542, 29611.259718507208, 29968.550471742506, 32330.676693232766, 32447.351052978334, 25806.225813225632, 31008.0, 32326.83836580802, 32598.837005814818, 33699.15752106119, 30424.239394015327, 30626.234344140685, 30750.0, 30782.692173077983, 32416.513752293264, 28096.157115286573, 28932.764618929526, 29487.115386538437, 29565.0, 29599.112026639235, 22986.885065574566, 31619.84190079035, 32854.342913141125, 32896.83551582227, 33126.0], "unit": "score", "name": "ext.html", "value": 16514.071301276537}, {"lowerIsBetter": false, "replicates": [334.3346739987425, 335.3895909444811, 336.4079220571793, 338.0955942852868, 338.4246780473196, 12101.757964840697, 12547.937260313709, 15120.470783522578, 15299.0, 15694.215289235535, 12303.63089107326, 14500.564983050499, 14738.115713057225, 15152.54542363728, 15158.621034474143, 4476.776161191944, 4765.3566768486335, 4869.245266983615, 4910.582600478946, 5011.423686276088, 4941.752912354368, 4979.60163186946, 4980.0288943656005, 4981.651284410093, 4982.850514484553, 4747.145513807513, 4926.11329960607, 4930.0, 4957.0, 4958.504149585049, 4946.678465899723, 4970.6520543561965, 4978.751062446863, 4981.078500477387, 4981.72600506972, 4306.7631280279575, 4436.755978421185, 4444.177827101997, 4446.555344465528, 4446.822127114911, 18950.43148705541, 18952.5261868453, 19539.706904396444, 19819.10814013373, 19886.502837429034, 1871.6256748650324, 1893.943181704551, 1947.6396866579587, 1955.8728682635583, 2015.939521814348, 12436.440360183722, 12441.688957776038, 12450.190737602026, 12523.749525009449, 13081.41133648988, 1723.1987125986477, 1744.9040302783342, 1744.9127543622767, 1774.1838754173095, 1806.756087928139, 52870.735646321904, 54453.45546544524, 55697.88604227933, 55870.72064639691, 56165.71917140429, 9261.67584134552, 9379.24966002718, 9510.09654082861, 9544.236461083097, 9631.277654175965, 10175.44035078063, 10712.732181695364, 11036.227464077598, 12049.337286449154, 12051.939740301243, 6691.397774200345, 6722.126123603998, 6780.254172041072, 6822.11312529368, 6824.556403833735, 6410.871782564416, 6427.393151712072, 6436.292007879129, 6497.220333560003, 6508.3491650835485, 5653.745581448845, 5713.428657134336, 5716.42835716425, 5716.485516303469, 5787.450192231731, 1667.1580851669828, 1678.127373765635, 1691.687037897993, 1693.8052124005897, 1694.7203711387483, 365.42445648103813, 368.3094198378041, 371.2445174070807, 381.07969254250673, 820.885076089348, 8635.309175265964, 9208.171264586219, 9363.62545498186, 9540.809183816285, 9868.062534059252, 381.18806941215587, 746.2127455534355, 853.9231469167805, 886.0607755778766, 912.6896855069308, 7698.152185248342, 8089.595520223966, 8593.011803642661, 8659.740207793777, 8749.781255468664, 437759.0, 445323.0, 458203.0, 459730.0, 460819.0, 55685.44314556884, 55823.441765581825, 65024.674876625315, 65587.0, 70487.64756176186, 416.07008336368193, 420.130330216449, 425.4277996095247, 429.33024481807854, 430.9870703878889, 9090.545472726206, 9219.308551858503, 9245.121713437213, 9450.196733277473, 9644.9035509644, 34601.48097778485, 35247.999999998974, 35898.46152307665, 36140.73507427228, 36602.26795464129, 47155.76422117867, 48054.5194548064, 48190.0, 49713.75143124406, 50780.746096269286, 8471.534065626449, 8693.30453563726, 8773.29813614922, 8775.210231079234, 9307.72076837696, 16163.191840408168, 16177.272022758769, 16485.58786030359, 16600.916995414944, 16912.32350705958, 13554.457821687021, 13860.376283067084, 13958.930205348908, 14051.0, 14118.0, 13172.341382931007, 13212.339383031001, 13625.523106691218, 13782.93108534451, 14159.858401415853, 13339.66650833737, 13593.252371119683, 13612.183269003892, 13623.250721210032, 14271.57185284443, 8064.637091331021, 8082.838343232985, 8094.554799486084, 8105.392095592736, 8813.735587932373, 13312.201267923956, 13369.732605348034, 13619.455221791413, 13855.584332470042, 13949.721005580035], "unit": "score", "name": "jquery.html", "value": 7697.683930026536}, {"lowerIsBetter": false, "replicates": [1231.7721221574004, 1579.076240399366, 1653.3717187468765, 1655.3957805401033, 1699.736540836171, 6161.3530579289145, 6928.099347084878, 6976.1628604567395, 7034.683439245234, 7066.611336376497, 6965.233824279325, 7136.322049405311, 7191.173015103264, 7191.856162876752, 7197.7480788172425, 1699.983000170001, 1728.6456276463357, 1957.4812674641232, 1992.7110568967491, 2026.0275067967384, 1993.9202431902706, 1997.071361816755, 1998.4004798560375, 2005.759308882936, 2006.388051644248, 1964.3419454482766, 1970.0543739005286, 2025.5948810238012, 2027.8681885677383, 2032.369965310751, 1981.9207231710714, 2002.1490866381803, 2010.829079528242, 2022.413500084981, 2022.7067075274076, 2060.732104826378, 2076.688496725488, 2081.198738485679, 2085.0304608357037, 2086.019570801736, 7144.749933752294, 7171.89242161368, 7213.062301900719, 7223.494355395124, 7234.240404757477, 4080.0, 4151.543330233671, 4158.521769996459, 4165.562615925345, 4168.541460439349, 2522.5081109183716, 2622.6721659792524, 2637.907673231447, 2643.41844794145, 2645.1403293929357, 848.1349023995551, 855.9400841941067, 861.8276344731016, 862.0431321233426, 883.6421249394006, 9310.115539023782, 9318.25453963688, 9339.066093390607, 9383.718488445289, 9387.342885997983, 3687.723420743455, 3776.37689781183, 3805.6384643458828, 3809.29528037314, 3814.4659747635355, 8023.277904988462, 8025.719099831478, 8041.678332866737, 8055.556944367999, 8074.434789564674, 4075.38869169621, 4105.137921036616, 4121.711480196357, 4124.237016151961, 4136.462259906193, 3724.162063535737, 3737.4020156774786, 3761.4169803680475, 3763.7365384423374, 3766.1714422826935, 2893.8842446302333, 2933.8093023953375, 3275.5414242006136, 3288.0629020729457, 3372.3423932332958, 1055.8152323343384, 1063.6330465989222, 1071.689210129054, 1072.6674730833467, 1078.4338222433284, 924.4314746430897, 925.4447331600985, 985.2512090811035, 1071.1537885070863, 1172.9178957472895, 6530.706118224692, 6564.409203171737, 6570.441512471398, 6593.0, 6601.570897891622, 1111.6720567432626, 1131.140333346646, 1138.5901075612774, 1146.541383446628, 1158.9478473468714, 5161.0, 5185.792568297301, 5211.270422140903, 5217.060929032735, 5225.529702326809, 8184.918150818535, 8378.748637540884, 8382.036065852504, 8445.451045682134, 8447.535385553854, 8316.085230624627, 8391.958040209882, 8393.244607985189, 8396.538190399464, 8398.160183981552, 6595.142631457879, 6679.666016699242, 6721.630310332978, 6734.0572319875255, 6828.829279267959, 6737.9556168793915, 6791.762288320083, 6792.966035169792, 6804.285550017375, 6804.55770374924, 7005.824854378681, 7417.8887316689215, 7511.887321690069, 7530.811729706801, 7714.1128770192145, 7590.392768578611, 7686.346660533917, 7752.26353496417, 7813.14055453911, 7927.088384835818, 5850.180974663465, 5857.121431785095, 5916.615419997686, 5917.467427931507, 5938.524918006636, 5863.413658634103, 6083.361247069171, 6095.481884039907, 6528.314526974599, 6716.1604799400075, 6312.779052733133, 6372.299047104722, 6436.549441539235, 6465.127207827071, 6554.4756419487285, 6342.809715708536, 6357.90463143044, 6432.6462044588, 6436.6459844707115, 6462.030695395728, 6122.846928826815, 6239.656818875005, 6247.125402443752, 6297.842553936188, 6332.208473940757, 5967.91048134287, 6018.699065046818, 6019.458248757633, 6019.72911219005, 6030.03519436888, 5683.8010669626365, 5828.795992140254, 5854.9121763174435, 5872.0898260769645, 5884.117382392676], "unit": "score", "name": "mootools.html", "value": 4022.391749775418}, {"lowerIsBetter": false, "replicates": [291.53209099395457, 291.699549464052, 294.5008211082214, 298.49703250023714, 301.08770425610396, 5333.413324534303, 5376.838694839156, 5399.379071406789, 5399.62202645815, 5411.0530657135, 5279.208118782185, 5280.603954703403, 5289.867753306169, 5290.656107353019, 5309.150535914255, 4102.692298077641, 4106.650934670557, 4107.322291821846, 4108.794560271975, 4112.239235741383, 3950.0519875229884, 4055.2700513907484, 4117.21772863155, 4118.732282401635, 4122.628963393294, 3966.266240745457, 4008.739431936929, 4020.5376381716037, 4037.5962403759536, 4050.2911990401562, 4111.938320925188, 4116.670666346715, 4123.154753275571, 4124.072083781125, 4124.8762537123785, 3613.5663720353464, 3616.801075940822, 3622.040159357746, 3624.257027309395, 3628.4194528875255, 4896.681715688469, 5045.974770126162, 5065.974670126662, 5175.611829112831, 5181.844544663666, 4688.320193571947, 4688.624910007191, 4695.67130300879, 4704.223803072489, 4708.105459962596, 5636.379998200195, 5638.295213098363, 5642.238297829823, 5645.604807663465, 5652.378238393773, 3802.049487628093, 3866.1881004988986, 3898.5516665583536, 3910.1202229498135, 3911.3350730375905, 5910.793122240744, 5911.793087241926, 5918.141869428909, 5925.614835035709, 5928.140419639129, 3951.920961580752, 3951.92096158081, 3956.604339566078, 3958.6041395860184, 3959.3269144245546, 3915.980420097881, 4012.3981402789814, 4019.1157945252, 4022.557518672944, 4023.376376661622, 4656.464506581787, 4692.343071969859, 4714.457837348748, 4717.268823332389, 4717.457492388351, 5603.495685388253, 5609.859753506195, 5611.6352437091455, 5615.606907516435, 5623.971880140655, 1441.891858110646, 1461.8976671632884, 1463.4219483304034, 1463.677990842013, 1464.1361596658023, 994.5226291380178, 994.855745916838, 994.9005099489993, 998.0368943969105, 1022.2844009193594, 4951.925721114186, 4958.826441074545, 4959.752012399365, 4961.454240033666, 4965.726885021286, 5838.883222335529, 5839.474447299764, 5840.88318233633, 5845.0, 5846.41535846412, 4960.330355402047, 4961.3798275215595, 4964.404271487372, 4967.279744437036, 4970.3538539990295, 3071.416430878126, 3109.284864481182, 3122.7814053016073, 3140.8586613602442, 3142.528620706912, 5529.087700529448, 5534.612577119644, 5535.944640553543, 5537.556995440355, 5540.445955404427, 5976.491998180117, 5991.730372133265, 5995.2206213192, 5995.430434108753, 6008.4592386684535, 5518.696471694096, 5523.4200408956485, 5527.613067085265, 5530.806421775219, 5533.22534845122, 5657.971710141423, 5826.475617194473, 5827.562932779973, 5830.47525722687, 5832.0, 5680.261565996394, 5681.715914204356, 5689.34572524165, 5694.088945768657, 5697.772089116389, 5523.199136125159, 5524.558035357081, 5526.972365138309, 5530.778768849201, 5537.335519737658, 4006.2187873364414, 4087.5503694592976, 4093.8771836844944, 4096.938545921754, 4100.302948498822, 5568.805091821767, 5759.683217422914, 5817.0983497557945, 5819.738111784895, 5822.301323841166, 5489.58828087887, 5630.60585758993, 5645.266115404971, 5648.71756412186, 5650.57620678459, 5623.606347555632, 5625.887482250414, 5629.408912064338, 5632.971835140798, 5633.577481688972, 5377.2740680009265, 5499.312585926759, 5504.422035686195, 5507.394186639546, 5517.586181036358, 5671.801486948102, 5678.063119585222, 5678.14827775837, 5681.375048744552, 5686.715664216856, 5535.197396377423, 5536.363318218457, 5542.944570554243, 5543.584231182596, 5547.5007249347755], "unit": "score", "name": "prototype.html", "value": 4212.7836367468735}, {"lowerIsBetter": false, "replicates": [664.6743095883015, 694.1358009278449, 718.4755128756008, 742.302235898256, 749.1459735901074, 10878.891211087886, 11134.16493762968, 11142.33146011239, 11176.441177941091, 12708.872911270884, 12568.497260109607, 12608.369581520934, 12639.0, 12671.809922851164, 12681.556145534909, 633.7908490198223, 642.6882961763564, 793.2662287384176, 794.1819925476753, 807.168616325186, 795.8010497375656, 796.4862663581986, 803.441608082383, 803.4616806739499, 803.9959800200991, 831.9292860106898, 839.8740188971673, 839.9580020998956, 840.0381563110235, 840.1262686805745, 644.8387903024244, 655.1908393134476, 815.0463957170125, 831.6631764135474, 832.7793134819217, 605.2434456928839, 610.4597431273311, 610.5176910240905, 610.6732897899647, 610.6885488400903, 11671.649850504498, 11908.34504102274, 11935.403229838474, 11941.10441716866, 11945.343006134659, 11115.666530004113, 11181.273217240854, 11187.384693841836, 11674.474648640831, 12137.271763694207, 9047.004829468753, 9068.093190680946, 9214.723558293263, 9359.625614975394, 9402.670906518308, 3159.0680749179046, 3212.646608873022, 3214.8874789382257, 3249.545063691085, 3251.4472539668313, 41433.0, 41565.0, 41576.1684766306, 41732.79133604313, 41750.1649967002, 9652.435131617345, 9701.07839755222, 9822.312438129262, 9828.361156524803, 9877.111060004634, 17480.300787968594, 17647.73528397075, 17663.82336176622, 17692.646147076986, 17719.557011074827, 6644.435223006002, 6684.364985326386, 6733.8653226935185, 6736.8989465158065, 6842.6578671066245, 3364.6467120951947, 3418.8461519231696, 3459.9481007784902, 3536.664016918389, 3572.9523242546325, 2543.4658721668657, 2561.8334808237405, 2573.5110329037425, 2573.5238980788613, 2574.472233192191, 455.92933095370273, 457.71621594611554, 464.1969392950148, 470.7834396177728, 471.51198509542456, 435.40132318062666, 444.02314907204277, 549.5027000564495, 579.6753817862011, 580.9302883653988, 6436.871262574722, 6492.058651495507, 7403.889416587447, 7646.0, 7827.960860195776, 481.53531841772855, 533.9385970613351, 569.3026043097173, 572.1046562130252, 577.0910815465659, 3399.3711163434846, 3466.4107101792756, 3496.6852983231634, 3525.7355698322726, 3737.8691745788765, 49157.0, 49766.253506197434, 49829.75085124551, 49912.251316230286, 50193.24710129351, 44225.0, 44251.557484425386, 44563.777181114536, 44657.330140047925, 44809.775951120035, 39590.406143907865, 39872.60127398747, 40333.77329813608, 41010.79494602508, 41155.0, 7358.227386124594, 7446.664900079401, 7470.887936680845, 7489.21363256872, 7503.212162723054, 31395.68604314019, 31399.21501962469, 31580.368392632477, 31750.364992700477, 31761.841190793897, 35421.64578354183, 35836.462453063745, 38298.617013829506, 39186.4122038164, 39577.802110990415, 9227.76930576741, 9346.859797103185, 9470.14768670823, 10026.92998204662, 10187.796244075225, 10345.327553709287, 10454.895451045391, 10650.520726567169, 10903.83644245321, 11014.735082035791, 9548.952255238679, 9631.951840240754, 9733.902660973583, 10094.343867648578, 10419.114375277883, 9823.0, 9957.352772069793, 10026.899731002597, 10555.525001374803, 10848.349099054081, 8768.868466973128, 9137.08629137081, 9290.16388525036, 10023.198144148304, 10384.169266458815, 8365.330773538224, 8424.663013479392, 8555.401121921406, 8612.354073444392, 8978.86531702012, 8171.673133074611, 8316.501009939422, 8358.23270011885, 8691.304695624209, 8800.779980500283], "unit": "score", "name": "yui.html", "value": 5584.502458894976}], "name": "dromaeo_css", "value": 6178.744763433893}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 112.0, 113.0, 113.0, 102.0, 112.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 153.0, 166.0, 135.0, 155.0, 154.0, 129.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 160.0, 161.0, 160.0, 159.0, 160.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 78.0, 92.0, 74.0, 72.0, 72.0, 116.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 135.0, 93.0, 94.0, 93.0, 135.0, 94.0, 94.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 71.0, 72.0, 71.0, 81.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 93.0, 83.0, 85.0, 86.0, 85.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 129.0, 147.0, 115.0, 127.0, 121.0, 129.0, 119.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 149.0, 150.0, 148.0, 135.0, 150.0, 147.0, 148.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 76.0, 71.0, 70.0, 70.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1520.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [27081.08108108108], "unit": "score", "name": "RegExp", "value": 33.63916666666665}, {"lowerIsBetter": false, "replicates": [609.0133982947625], "unit": "score", "name": "Splay", "value": 133.80822200000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19841.275677877496}]} 07:10:55 INFO - RETURN: dromaeo_css: 6178.74 07:10:55 INFO - RETURN: kraken: 1520.40 07:10:55 INFO - RETURN: v8_7: 19841.28 07:10:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19841.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1520.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6178.74"}}} 07:10:55 INFO - Return code: 0 07:10:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:55 ERROR - # TBPL SUCCESS # 07:10:55 INFO - Running post-action listener: _resource_record_post_action 07:10:55 INFO - Running post-run listener: _resource_record_post_run 07:10:56 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558473216; Read time: 12; Write time: 917724 07:10:56 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 244903936; Read time: 0; Write time: 568496 07:10:56 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313569280; Read time: 12; Write time: 349228 07:10:56 INFO - Running post-run listener: _upload_blobber_files 07:10:56 INFO - Blob upload gear active. 07:10:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:10:56 INFO - Copying logs to upload dir... 07:10:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.866753 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 07:10:56.178418) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:56.182407) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009984 build_url: 'https://queue.taskcluster.net/v1/task/r6aewZTjQoeFV8bg2liNdw/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-18 07:10:56.233251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:56.233559) ========= 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=01deea79d00cc2c334834894000001d2-1450445652.221441-2101921951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:10:56.282521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 07:10:56.282823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 07:10:56.283101) ========= ========= Total master_lag: 0.24 =========