builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1450403499.53 results: success (0) buildid: 20151217170415 builduid: 040a8fa2e2354fac96173be5d901cdc3 revision: e1ce5b4fa814367b46379641a77f06eabd9348ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.529630) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.533015) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.533487) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006205 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.558400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.558869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.573890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.574424) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.626192) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.626730) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.631682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.632167) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 17:51:39-- 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% 20.1M=0.001s 2015-12-17 17:51:40 (20.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.767966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.768483) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.820171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:39.820701) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1ce5b4fa814367b46379641a77f06eabd9348ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e1ce5b4fa814367b46379641a77f06eabd9348ed --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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 17:51:40,154 truncating revision to first 12 chars 2015-12-17 17:51:40,154 Setting DEBUG logging. 2015-12-17 17:51:40,154 attempt 1/10 2015-12-17 17:51:40,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1ce5b4fa814?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 17:51:40,401 unpacking tar archive at: fx-team-e1ce5b4fa814/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:40.354457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:40.354812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:40.370021) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:40.370415) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:51:40.370884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-17 17:51:40.371196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:51:40 INFO - MultiFileLogger online at 20151217 17:51:40 in /builds/slave/test 17:51:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:51:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:51:40 INFO - {'append_to_log': False, 17:51:40 INFO - 'base_work_dir': '/builds/slave/test', 17:51:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:51:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:51:40 INFO - 'branch': 'Fx-Team-Non-PGO', 17:51:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:51:40 INFO - 'config_files': ('talos/linux_config.py',), 17:51:40 INFO - 'default_actions': ('clobber', 17:51:40 INFO - 'read-buildbot-config', 17:51:40 INFO - 'download-and-extract', 17:51:40 INFO - 'populate-webroot', 17:51:40 INFO - 'create-virtualenv', 17:51:40 INFO - 'install', 17:51:40 INFO - 'run-tests'), 17:51:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:51:40 INFO - 'download_minidump_stackwalk': True, 17:51:40 INFO - 'download_symbols': 'ondemand', 17:51:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:51:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:51:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:51:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:51:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:51:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:51:40 INFO - 'installer_path': 'installer.exe', 17:51:40 INFO - 'log_level': 'info', 17:51:40 INFO - 'log_name': 'talos', 17:51:40 INFO - 'log_to_console': True, 17:51:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:51:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:51:40 INFO - 'opt_config_files': (), 17:51:40 INFO - 'pip_index': False, 17:51:40 INFO - 'sps_profile': False, 17:51:40 INFO - 'sps_profile_interval': 0, 17:51:40 INFO - 'suite': 'dromaeojs', 17:51:40 INFO - 'system_bits': '64', 17:51:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:51:40 INFO - 'title': 'talos-linux64-ix-036', 17:51:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:51:40 INFO - 'use_talos_json': True, 17:51:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:51:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:51:40 INFO - 'work_dir': 'build'} 17:51:40 INFO - ##### 17:51:40 INFO - ##### Running clobber step. 17:51:40 INFO - ##### 17:51:40 INFO - Running pre-action listener: _resource_record_pre_action 17:51:40 INFO - Running main action method: clobber 17:51:40 INFO - rmtree: /builds/slave/test/build 17:51:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:51:41 INFO - Running post-action listener: _resource_record_post_action 17:51:41 INFO - ##### 17:51:41 INFO - ##### Running read-buildbot-config step. 17:51:41 INFO - ##### 17:51:41 INFO - Running pre-action listener: _resource_record_pre_action 17:51:41 INFO - Running main action method: read_buildbot_config 17:51:41 INFO - Using buildbot properties: 17:51:41 INFO - { 17:51:41 INFO - "project": "", 17:51:41 INFO - "product": "firefox", 17:51:41 INFO - "script_repo_revision": "production", 17:51:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:51:41 INFO - "repository": "", 17:51:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:51:41 INFO - "buildid": "20151217170415", 17:51:41 INFO - "pgo_build": "False", 17:51:41 INFO - "basedir": "/builds/slave/test", 17:51:41 INFO - "buildnumber": 2229, 17:51:41 INFO - "slavename": "talos-linux64-ix-036", 17:51:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:51:41 INFO - "platform": "ubuntu64_hw", 17:51:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:51:41 INFO - "branch": "fx-team", 17:51:41 INFO - "repo_path": "integration/fx-team", 17:51:41 INFO - "revision": "e1ce5b4fa814367b46379641a77f06eabd9348ed", 17:51:41 INFO - "stage_platform": "linux64", 17:51:41 INFO - "builduid": "040a8fa2e2354fac96173be5d901cdc3", 17:51:41 INFO - "slavebuilddir": "test" 17:51:41 INFO - } 17:51:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:51:41 INFO - Running post-action listener: _resource_record_post_action 17:51:41 INFO - ##### 17:51:41 INFO - ##### Running download-and-extract step. 17:51:41 INFO - ##### 17:51:41 INFO - Running pre-action listener: _resource_record_pre_action 17:51:41 INFO - Running main action method: download_and_extract 17:51:41 INFO - mkdir: /builds/slave/test/build/tests 17:51:41 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')]} 17:51:41 INFO - https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/test_packages.json 17:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/test_packages.json 17:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:51:42 INFO - Downloaded 1302 bytes. 17:51:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:51:42 INFO - Using the following test package requirements: 17:51:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:51:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:51:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'jsshell-linux-x86_64.zip'], 17:51:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:51:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:51:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:51:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:51:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:51:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:51:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:51:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:42 INFO - https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:43 INFO - Downloaded 21870957 bytes. 17:51:43 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 17:51:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:43 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 17:51:44 INFO - Return code: 0 17:51:44 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 17:51: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')]} 17:51:44 INFO - https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:45 INFO - Downloaded 21870957 bytes. 17:51:45 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 17:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:51:45 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 17:51:46 INFO - Return code: 0 17:51:46 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')]} 17:51:46 INFO - https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:47 INFO - Downloaded 11132039 bytes. 17:51:47 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 17:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:51:47 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 17:51:47 INFO - Return code: 0 17:51: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')]} 17:51:47 INFO - https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KTJF1JIjRdC93-LnnksKRQ/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 17:51:49 INFO - Downloaded 53015239 bytes. 17:51:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:51:49 INFO - mkdir: /builds/slave/test/properties 17:51:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:51:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:51:49 INFO - Contents: 17:51:49 INFO - build_url:https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:51:49 INFO - Running post-action listener: _resource_record_post_action 17:51:49 INFO - Running post-action listener: set_extra_try_arguments 17:51:49 INFO - ##### 17:51:49 INFO - ##### Running populate-webroot step. 17:51:49 INFO - ##### 17:51:49 INFO - Running pre-action listener: _resource_record_pre_action 17:51:49 INFO - Running main action method: populate_webroot 17:51:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:51:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:51:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:51:49 INFO - '--tppagecycles', 17:51:49 INFO - '7'], 17:51:49 INFO - 'tests': ['tsvgm']}}, 17:51:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:51:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:51:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:51:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:51:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'tests': ['damp', 'tps']}, 17:51:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['damp', 'tps']}, 17:51:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:51:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:51:49 INFO - 'other': {'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'other_l64': {'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'other_nol64': {'tests': ['a11yr', 17:51:49 INFO - 'ts_paint', 17:51:49 INFO - 'tpaint', 17:51:49 INFO - 'sessionrestore', 17:51:49 INFO - 'sessionrestore_no_auto_restore']}, 17:51:49 INFO - 'svgr': {'tests': ['tsvgx', 17:51:49 INFO - 'tsvgr_opacity', 17:51:49 INFO - 'tart', 17:51:49 INFO - 'tscrollx', 17:51:49 INFO - 'cart']}, 17:51:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['tsvgx', 17:51:49 INFO - 'tsvgr_opacity', 17:51:49 INFO - 'tart', 17:51:49 INFO - 'tscrollx', 17:51:49 INFO - 'cart']}, 17:51:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'tests': ['tp5o']}, 17:51:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'talos_options': ['--e10s'], 17:51:49 INFO - 'tests': ['tp5o']}, 17:51:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'talos_options': ['--xperf_path', 17:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:49 INFO - 'tests': ['tp5n']}, 17:51:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:51:49 INFO - 'talos_options': ['--e10s', 17:51:49 INFO - '--xperf_path', 17:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:49 INFO - 'tests': ['tp5n']}}, 17:51:49 INFO - 'talos.zip': {'path': '', 17:51:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:51:49 INFO - Running post-action listener: _resource_record_post_action 17:51:49 INFO - ##### 17:51:49 INFO - ##### Running create-virtualenv step. 17:51:49 INFO - ##### 17:51:49 INFO - Running pre-action listener: _resource_record_pre_action 17:51:49 INFO - Running main action method: create_virtualenv 17:51:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:51:49 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 17:51:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:51:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:51:49 INFO - Using real prefix '/usr' 17:51:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:51:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:51:51 INFO - Installing pip.................done. 17:51:51 INFO - Return code: 0 17:51:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:51:51 INFO - Using env: {'DISPLAY': ':0', 17:51:51 INFO - 'HOME': '/home/cltbld', 17:51:51 INFO - 'LANG': 'en_US.UTF-8', 17:51:51 INFO - 'LANGUAGE': 'en_US:en', 17:51:51 INFO - 'LOGNAME': 'cltbld', 17:51:51 INFO - 'MAIL': '/var/mail/cltbld', 17:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:51 INFO - 'MOZ_NO_REMOTE': '1', 17:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:51 INFO - 'NO_EM_RESTART': '1', 17:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:51 INFO - 'PWD': '/builds/slave/test', 17:51:51 INFO - 'SHELL': '/bin/bash', 17:51:51 INFO - 'SHLVL': '1', 17:51:51 INFO - 'TERM': 'linux', 17:51:51 INFO - 'TMOUT': '86400', 17:51:51 INFO - 'USER': 'cltbld', 17:51:51 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:51 INFO - '_': '/tools/buildbot/bin/python'} 17:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:51 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 17:51:51 INFO - Cleaning up... 17:51:51 INFO - Return code: 0 17:51:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:51:51 INFO - Using env: {'DISPLAY': ':0', 17:51:51 INFO - 'HOME': '/home/cltbld', 17:51:51 INFO - 'LANG': 'en_US.UTF-8', 17:51:51 INFO - 'LANGUAGE': 'en_US:en', 17:51:51 INFO - 'LOGNAME': 'cltbld', 17:51:51 INFO - 'MAIL': '/var/mail/cltbld', 17:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:51 INFO - 'MOZ_NO_REMOTE': '1', 17:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:51 INFO - 'NO_EM_RESTART': '1', 17:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:51 INFO - 'PWD': '/builds/slave/test', 17:51:51 INFO - 'SHELL': '/bin/bash', 17:51:51 INFO - 'SHLVL': '1', 17:51:51 INFO - 'TERM': 'linux', 17:51:51 INFO - 'TMOUT': '86400', 17:51:51 INFO - 'USER': 'cltbld', 17:51:51 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:51 INFO - '_': '/tools/buildbot/bin/python'} 17:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:52 INFO - Downloading/unpacking psutil>=0.7.1 17:51:52 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 17:51:52 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 17:51:52 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 17:51:52 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 17:51:52 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 17:51:52 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 17:51:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:51:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:53 INFO - Installing collected packages: psutil 17:51:53 INFO - Running setup.py install for psutil 17:51:54 INFO - building 'psutil._psutil_linux' extension 17:51:54 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 17:51:54 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 17:51:54 INFO - building 'psutil._psutil_posix' extension 17:51:54 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 17:51:54 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 17:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:54 INFO - Successfully installed psutil 17:51:54 INFO - Cleaning up... 17:51:54 INFO - Return code: 0 17:51:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:51:54 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')]} 17:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:54 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')]} 17:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:54 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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:51:54 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 17:51:54 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 17:51:54 INFO - Using env: {'DISPLAY': ':0', 17:51:54 INFO - 'HOME': '/home/cltbld', 17:51:54 INFO - 'LANG': 'en_US.UTF-8', 17:51:54 INFO - 'LANGUAGE': 'en_US:en', 17:51:54 INFO - 'LOGNAME': 'cltbld', 17:51:54 INFO - 'MAIL': '/var/mail/cltbld', 17:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:54 INFO - 'MOZ_NO_REMOTE': '1', 17:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:54 INFO - 'NO_EM_RESTART': '1', 17:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:54 INFO - 'PWD': '/builds/slave/test', 17:51:54 INFO - 'SHELL': '/bin/bash', 17:51:54 INFO - 'SHLVL': '1', 17:51:54 INFO - 'TERM': 'linux', 17:51:54 INFO - 'TMOUT': '86400', 17:51:54 INFO - 'USER': 'cltbld', 17:51:54 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:54 INFO - '_': '/tools/buildbot/bin/python'} 17:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:51:54 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 17:51:54 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 17:51:54 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 17:51:54 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 17:51:54 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 17:51:54 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 17:51:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:51:56 INFO - Installing collected packages: mozsystemmonitor 17:51:56 INFO - Running setup.py install for mozsystemmonitor 17:51:56 INFO - Successfully installed mozsystemmonitor 17:51:56 INFO - Cleaning up... 17:51:56 INFO - Return code: 0 17:51:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:56 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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:51:56 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 17:51:56 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 17:51:56 INFO - Using env: {'DISPLAY': ':0', 17:51:56 INFO - 'HOME': '/home/cltbld', 17:51:56 INFO - 'LANG': 'en_US.UTF-8', 17:51:56 INFO - 'LANGUAGE': 'en_US:en', 17:51:56 INFO - 'LOGNAME': 'cltbld', 17:51:56 INFO - 'MAIL': '/var/mail/cltbld', 17:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:56 INFO - 'MOZ_NO_REMOTE': '1', 17:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:56 INFO - 'NO_EM_RESTART': '1', 17:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:56 INFO - 'PWD': '/builds/slave/test', 17:51:56 INFO - 'SHELL': '/bin/bash', 17:51:56 INFO - 'SHLVL': '1', 17:51:56 INFO - 'TERM': 'linux', 17:51:56 INFO - 'TMOUT': '86400', 17:51:56 INFO - 'USER': 'cltbld', 17:51:56 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:56 INFO - '_': '/tools/buildbot/bin/python'} 17:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:51:56 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 17:51:56 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 17:51:56 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 17:51:56 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 17:51:56 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 17:51:56 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 17:51:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:59 INFO - Downloading docopt-0.6.1.tar.gz 17:51:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:59 INFO - Running setup.py install for blobuploader 17:51:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:59 INFO - Running setup.py install for requests 17:51:59 INFO - Running setup.py install for docopt 17:51:59 INFO - Successfully installed blobuploader requests docopt 17:51:59 INFO - Cleaning up... 17:51:59 INFO - Return code: 0 17:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:59 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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:51:59 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 17:51:59 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 17:51:59 INFO - Using env: {'DISPLAY': ':0', 17:51:59 INFO - 'HOME': '/home/cltbld', 17:51:59 INFO - 'LANG': 'en_US.UTF-8', 17:51:59 INFO - 'LANGUAGE': 'en_US:en', 17:51:59 INFO - 'LOGNAME': 'cltbld', 17:51:59 INFO - 'MAIL': '/var/mail/cltbld', 17:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:59 INFO - 'MOZ_NO_REMOTE': '1', 17:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:59 INFO - 'NO_EM_RESTART': '1', 17:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:59 INFO - 'PWD': '/builds/slave/test', 17:51:59 INFO - 'SHELL': '/bin/bash', 17:51:59 INFO - 'SHLVL': '1', 17:51:59 INFO - 'TERM': 'linux', 17:51:59 INFO - 'TMOUT': '86400', 17:51:59 INFO - 'USER': 'cltbld', 17:51:59 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:59 INFO - '_': '/tools/buildbot/bin/python'} 17:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:00 INFO - Running setup.py (path:/tmp/pip-qfxlp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:00 INFO - Running setup.py (path:/tmp/pip-CwOVym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:00 INFO - Running setup.py (path:/tmp/pip-ST_5Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:00 INFO - Running setup.py (path:/tmp/pip-xkkOha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:00 INFO - Running setup.py (path:/tmp/pip-u1l1bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:00 INFO - Running setup.py (path:/tmp/pip-JzuFFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:00 INFO - Running setup.py (path:/tmp/pip-Ke4l3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:00 INFO - Running setup.py (path:/tmp/pip-TvTmsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:00 INFO - Running setup.py (path:/tmp/pip-JkzGnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:00 INFO - Running setup.py (path:/tmp/pip-Vno6nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:00 INFO - Running setup.py (path:/tmp/pip-Qo71_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:00 INFO - Running setup.py (path:/tmp/pip-ujJvum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:00 INFO - Running setup.py (path:/tmp/pip-KJA1F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:00 INFO - Running setup.py (path:/tmp/pip-qFb7Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:01 INFO - Running setup.py (path:/tmp/pip-Q44duK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:01 INFO - Running setup.py (path:/tmp/pip-oitSNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:01 INFO - Running setup.py (path:/tmp/pip-dp0PHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:52:01 INFO - Running setup.py install for manifestparser 17:52:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:52:01 INFO - Running setup.py install for mozcrash 17:52:01 INFO - Running setup.py install for mozdebug 17:52:01 INFO - Running setup.py install for mozdevice 17:52:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:52:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:52:01 INFO - Running setup.py install for mozfile 17:52:01 INFO - Running setup.py install for mozhttpd 17:52:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:52:01 INFO - Running setup.py install for mozinfo 17:52:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:52:01 INFO - Running setup.py install for mozInstall 17:52:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Running setup.py install for mozleak 17:52:02 INFO - Running setup.py install for mozlog 17:52:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Running setup.py install for moznetwork 17:52:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Running setup.py install for mozprocess 17:52:02 INFO - Running setup.py install for mozprofile 17:52:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Running setup.py install for mozrunner 17:52:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:52:02 INFO - Running setup.py install for mozscreenshot 17:52:02 INFO - Running setup.py install for moztest 17:52:02 INFO - Running setup.py install for mozversion 17:52:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:52:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:52:03 INFO - Cleaning up... 17:52:03 INFO - Return code: 0 17:52:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52: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')]} 17:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52: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')]} 17:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 17:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 17:52:03 INFO - Using env: {'DISPLAY': ':0', 17:52:03 INFO - 'HOME': '/home/cltbld', 17:52:03 INFO - 'LANG': 'en_US.UTF-8', 17:52:03 INFO - 'LANGUAGE': 'en_US:en', 17:52:03 INFO - 'LOGNAME': 'cltbld', 17:52:03 INFO - 'MAIL': '/var/mail/cltbld', 17:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:03 INFO - 'MOZ_NO_REMOTE': '1', 17:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:03 INFO - 'NO_EM_RESTART': '1', 17:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:03 INFO - 'PWD': '/builds/slave/test', 17:52:03 INFO - 'SHELL': '/bin/bash', 17:52:03 INFO - 'SHLVL': '1', 17:52:03 INFO - 'TERM': 'linux', 17:52:03 INFO - 'TMOUT': '86400', 17:52:03 INFO - 'USER': 'cltbld', 17:52:03 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:03 INFO - '_': '/tools/buildbot/bin/python'} 17:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:03 INFO - Running setup.py (path:/tmp/pip-m2jnvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:03 INFO - Running setup.py (path:/tmp/pip-ZYh7ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:03 INFO - Running setup.py (path:/tmp/pip-0OadxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:03 INFO - Running setup.py (path:/tmp/pip-6WNdfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:03 INFO - Running setup.py (path:/tmp/pip-UAwXxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:03 INFO - Running setup.py (path:/tmp/pip-cgZRT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:03 INFO - Running setup.py (path:/tmp/pip-xdgIQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:03 INFO - Running setup.py (path:/tmp/pip-p6qTqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:03 INFO - Running setup.py (path:/tmp/pip-y93_ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:03 INFO - Running setup.py (path:/tmp/pip-_qQtu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:03 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)) 17:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:03 INFO - Running setup.py (path:/tmp/pip-zbewZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:04 INFO - Running setup.py (path:/tmp/pip-vDZsO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:04 INFO - Running setup.py (path:/tmp/pip-FIRB67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:04 INFO - Running setup.py (path:/tmp/pip-oQBWGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:04 INFO - Running setup.py (path:/tmp/pip-MkJCab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:04 INFO - Running setup.py (path:/tmp/pip-SKd4Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:04 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)) 17:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:04 INFO - Running setup.py (path:/tmp/pip-b1fkHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:04 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)) 17:52:04 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)) 17:52:04 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)) 17:52:04 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)) 17:52:04 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)) 17:52:04 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)) 17:52:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:52:04 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 17:52:04 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 17:52:04 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 17:52:04 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 17:52:04 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 17:52:04 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 17:52:06 INFO - Downloading blessings-1.5.1.tar.gz 17:52:06 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 17:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:52:06 INFO - Installing collected packages: blessings 17:52:06 INFO - Running setup.py install for blessings 17:52:06 INFO - Successfully installed blessings 17:52:06 INFO - Cleaning up... 17:52:06 INFO - Return code: 0 17:52:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:06 INFO - Reading from file tmpfile_stdout 17:52:06 INFO - Current package versions: 17:52:06 INFO - argparse == 1.2.1 17:52:06 INFO - blessings == 1.5.1 17:52:06 INFO - blobuploader == 1.2.4 17:52:06 INFO - docopt == 0.6.1 17:52:06 INFO - manifestparser == 1.1 17:52:06 INFO - mozInstall == 1.12 17:52:06 INFO - mozcrash == 0.16 17:52:06 INFO - mozdebug == 0.1 17:52:06 INFO - mozdevice == 0.47 17:52:06 INFO - mozfile == 1.2 17:52:06 INFO - mozhttpd == 0.7 17:52:06 INFO - mozinfo == 0.9 17:52:06 INFO - mozleak == 0.1 17:52:06 INFO - mozlog == 3.1 17:52:06 INFO - moznetwork == 0.27 17:52:06 INFO - mozprocess == 0.22 17:52:06 INFO - mozprofile == 0.27 17:52:06 INFO - mozrunner == 6.11 17:52:06 INFO - mozscreenshot == 0.1 17:52:06 INFO - mozsystemmonitor == 0.0 17:52:06 INFO - moztest == 0.7 17:52:06 INFO - mozversion == 1.4 17:52:06 INFO - psutil == 3.1.1 17:52:06 INFO - requests == 1.2.3 17:52:06 INFO - wsgiref == 0.1.2 17:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52: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')]} 17:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52: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')]} 17:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:52:06 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 17:52:06 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 17:52:06 INFO - Using env: {'DISPLAY': ':0', 17:52:06 INFO - 'HOME': '/home/cltbld', 17:52:06 INFO - 'LANG': 'en_US.UTF-8', 17:52:06 INFO - 'LANGUAGE': 'en_US:en', 17:52:06 INFO - 'LOGNAME': 'cltbld', 17:52:06 INFO - 'MAIL': '/var/mail/cltbld', 17:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:06 INFO - 'MOZ_NO_REMOTE': '1', 17:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:06 INFO - 'NO_EM_RESTART': '1', 17:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:06 INFO - 'PWD': '/builds/slave/test', 17:52:06 INFO - 'SHELL': '/bin/bash', 17:52:06 INFO - 'SHLVL': '1', 17:52:06 INFO - 'TERM': 'linux', 17:52:06 INFO - 'TMOUT': '86400', 17:52:06 INFO - 'USER': 'cltbld', 17:52:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:06 INFO - '_': '/tools/buildbot/bin/python'} 17:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 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)) 17:52:06 INFO - Cleaning up... 17:52:06 INFO - Return code: 0 17:52:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:52: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')]} 17:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52: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')]} 17:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:52:06 INFO - Using env: {'DISPLAY': ':0', 17:52:06 INFO - 'HOME': '/home/cltbld', 17:52:06 INFO - 'LANG': 'en_US.UTF-8', 17:52:06 INFO - 'LANGUAGE': 'en_US:en', 17:52:06 INFO - 'LOGNAME': 'cltbld', 17:52:06 INFO - 'MAIL': '/var/mail/cltbld', 17:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:06 INFO - 'MOZ_NO_REMOTE': '1', 17:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:06 INFO - 'NO_EM_RESTART': '1', 17:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:06 INFO - 'PWD': '/builds/slave/test', 17:52:06 INFO - 'SHELL': '/bin/bash', 17:52:06 INFO - 'SHLVL': '1', 17:52:06 INFO - 'TERM': 'linux', 17:52:06 INFO - 'TMOUT': '86400', 17:52:06 INFO - 'USER': 'cltbld', 17:52:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:06 INFO - '_': '/tools/buildbot/bin/python'} 17:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:07 INFO - Downloading/unpacking jsonschema 17:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:52:08 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 17:52:08 INFO - Downloading/unpacking functools32 (from jsonschema) 17:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:08 INFO - Downloading functools32-3.2.3-2.tar.gz 17:52:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:52:08 INFO - warning: no files found matching '*.txt' 17:52:08 INFO - no previously-included directories found matching 'build' 17:52:08 INFO - no previously-included directories found matching 'dist' 17:52:08 INFO - no previously-included directories found matching '.git*' 17:52:08 INFO - Installing collected packages: jsonschema, functools32 17:52:09 INFO - Running setup.py install for functools32 17:52:09 INFO - warning: no files found matching '*.txt' 17:52:09 INFO - no previously-included directories found matching 'build' 17:52:09 INFO - no previously-included directories found matching 'dist' 17:52:09 INFO - no previously-included directories found matching '.git*' 17:52:09 INFO - Successfully installed jsonschema functools32 17:52:09 INFO - Cleaning up... 17:52:09 INFO - Return code: 0 17:52:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:52: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')]} 17:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52: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')]} 17:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:52: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', '--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 0x7fa3a1287f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b3f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', '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 17:52:09 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 17:52:09 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 17:52:09 INFO - Using env: {'DISPLAY': ':0', 17:52:09 INFO - 'HOME': '/home/cltbld', 17:52:09 INFO - 'LANG': 'en_US.UTF-8', 17:52:09 INFO - 'LANGUAGE': 'en_US:en', 17:52:09 INFO - 'LOGNAME': 'cltbld', 17:52:09 INFO - 'MAIL': '/var/mail/cltbld', 17:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:09 INFO - 'MOZ_NO_REMOTE': '1', 17:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:09 INFO - 'NO_EM_RESTART': '1', 17:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:09 INFO - 'PWD': '/builds/slave/test', 17:52:09 INFO - 'SHELL': '/bin/bash', 17:52:09 INFO - 'SHLVL': '1', 17:52:09 INFO - 'TERM': 'linux', 17:52:09 INFO - 'TMOUT': '86400', 17:52:09 INFO - 'USER': 'cltbld', 17:52:09 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:09 INFO - '_': '/tools/buildbot/bin/python'} 17:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:09 INFO - Downloading/unpacking flake8 17:52:09 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 17:52:09 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 17:52:09 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 17:52:09 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 17:52:09 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 17:52:09 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 17:52:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:52:11 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 17:52:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:52:11 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 17:52:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52:11 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 17:52:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52: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 17:52:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:52:11 INFO - no previously-included directories found matching 'docs/_build' 17:52:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:52:11 INFO - Running setup.py install for pep8 17:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:52:11 INFO - no previously-included directories found matching 'docs/_build' 17:52:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:52:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:52:11 INFO - Cleaning up... 17:52:11 INFO - Return code: 0 17:52:11 INFO - Running post-action listener: _resource_record_post_action 17:52:11 INFO - Running post-action listener: _start_resource_monitoring 17:52:11 INFO - Starting resource monitoring. 17:52:11 INFO - ##### 17:52:11 INFO - ##### Running install step. 17:52:11 INFO - ##### 17:52:11 INFO - Running pre-action listener: _resource_record_pre_action 17:52:11 INFO - Running main action method: install 17:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:12 INFO - Reading from file tmpfile_stdout 17:52:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:52:12 INFO - Reading from file tmpfile_stdout 17:52:12 INFO - Output received: 17:52:12 INFO - Usage: mozinstall [options] installer 17:52:12 INFO - Options: 17:52:12 INFO - -h, --help show this help message and exit 17:52:12 INFO - -d DEST, --destination=DEST 17:52:12 INFO - Directory to install application into. [default: 17:52:12 INFO - "/builds/slave/test"] 17:52:12 INFO - --app=APP Application being installed. [default: firefox] 17:52:12 INFO - mkdir: /builds/slave/test/build/application 17:52:12 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'] 17:52:12 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 17:52:27 INFO - Reading from file tmpfile_stdout 17:52:27 INFO - Output received: 17:52:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:52:27 INFO - Running post-action listener: _resource_record_post_action 17:52:27 INFO - ##### 17:52:27 INFO - ##### Running run-tests step. 17:52:27 INFO - ##### 17:52:27 INFO - Running pre-action listener: _resource_record_pre_action 17:52:27 INFO - Running main action method: run_tests 17:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:52:27 INFO - Python 2.7.3 17:52:27 INFO - Return code: 0 17:52:27 INFO - grabbing minidump binary from tooltool 17:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:52:27 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 0x2bce0b0>, '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 0x2bcefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:52:27 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 17:52:27 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 17:52:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:52:27 INFO - Return code: 0 17:52:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:52:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:52:28 INFO - Return code: 0 17:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 17:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 17:52:28 INFO - Using env: {'DISPLAY': ':0', 17:52:28 INFO - 'HOME': '/home/cltbld', 17:52:28 INFO - 'LANG': 'en_US.UTF-8', 17:52:28 INFO - 'LANGUAGE': 'en_US:en', 17:52:28 INFO - 'LOGNAME': 'cltbld', 17:52:28 INFO - 'MAIL': '/var/mail/cltbld', 17:52:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:52:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:28 INFO - 'MOZ_NO_REMOTE': '1', 17:52:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:28 INFO - 'NO_EM_RESTART': '1', 17:52:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:28 INFO - 'PWD': '/builds/slave/test', 17:52:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:52:28 INFO - 'SHELL': '/bin/bash', 17:52:28 INFO - 'SHLVL': '1', 17:52:28 INFO - 'TERM': 'linux', 17:52:28 INFO - 'TMOUT': '86400', 17:52:28 INFO - 'USER': 'cltbld', 17:52:28 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684', 17:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:28 INFO - '_': '/tools/buildbot/bin/python'} 17:52:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 17:52:29 INFO - mozversion INFO | application_buildid: 20151217170415 17:52:29 INFO - mozversion INFO | application_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 17:52:29 INFO - mozversion INFO | application_display_name: Nightly 17:52:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:52:29 INFO - mozversion INFO | application_name: Firefox 17:52:29 INFO - mozversion INFO | application_remotingname: firefox 17:52:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:52:29 INFO - mozversion INFO | application_vendor: Mozilla 17:52:29 INFO - mozversion INFO | application_version: 46.0a1 17:52:29 INFO - mozversion INFO | platform_buildid: 20151217170415 17:52:29 INFO - mozversion INFO | platform_changeset: e1ce5b4fa814367b46379641a77f06eabd9348ed 17:52:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:52:29 INFO - mozversion INFO | platform_version: 46.0a1 17:52:29 INFO - 2015-12-17 17:52:29,138 DEBUG : using testdate: 1450403549 17:52:29 INFO - 2015-12-17 17:52:29,138 DEBUG : actual date: 1450403549 17:52:29 INFO - 2015-12-17 17:52:29,185 INFO : starting webserver on 'localhost:44399' 17:52:29 INFO - 2015-12-17 17:52:29,186 INFO : Starting test suite talos-linux64-ix-036 17:52:29 INFO - 2015-12-17 17:52:29,186 INFO : Starting test dromaeo_css 17:52:29 INFO - 2015-12-17 17:52:29,186 DEBUG : operating with platform_type : linux_ 17:52:29 INFO - 2015-12-17 17:52:29,187 INFO : Initialising browser for dromaeo_css test... 17:52:29 INFO - 2015-12-17 17:52:29,200 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvm00PT/profile http://localhost:44399/getInfo.html 17:52:33 INFO - 2015-12-17 17:52:33,900 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:52:33 INFO - 2015-12-17 17:52:33,900 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:52:33 INFO - 2015-12-17 17:52:33,900 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:52:33 INFO - 2015-12-17 17:52:33,900 DEBUG : BROWSER_OUTPUT: __metrics 17:52:34 INFO - 2015-12-17 17:52:34,264 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] 17:52:34 INFO - 2015-12-17 17:52:34,346 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] 17:52:35 INFO - 2015-12-17 17:52:35,719 INFO : Browser initialized. 17:52:35 INFO - 2015-12-17 17:52:35,720 INFO : Running cycle 1/1 for dromaeo_css test... 17:52:35 INFO - 2015-12-17 17:52:35,720 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvm00PT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:52:47 INFO - 2015-12-17 17:52:47,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 150237184 17:52:47 INFO - 2015-12-17 17:52:47,686 DEBUG : BROWSER_OUTPUT: 17:53:39 INFO - 2015-12-17 17:53:39,201 DEBUG : BROWSER_OUTPUT: 1450403619200 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] 17:55:51 INFO - 2015-12-17 17:55:51,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44399/tests/dromaeo/cssquery-ext.html) 17:55:52 INFO - 2015-12-17 17:55:52,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 250957824 17:55:52 INFO - 2015-12-17 17:55:52,595 DEBUG : BROWSER_OUTPUT: 17:58:55 INFO - 2015-12-17 17:58:55,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-ext.html (next: http://localhost:44399/tests/dromaeo/cssquery-jquery.html) 17:58:55 INFO - 2015-12-17 17:58:55,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 235180032 17:58:55 INFO - 2015-12-17 17:58:55,721 DEBUG : BROWSER_OUTPUT: 18:01:57 INFO - 2015-12-17 18:01:57,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44399/tests/dromaeo/cssquery-mootools.html) 18:01:58 INFO - 2015-12-17 18:01:58,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 233852928 18:01:58 INFO - 2015-12-17 18:01:58,389 DEBUG : BROWSER_OUTPUT: 18:05:00 INFO - 2015-12-17 18:05:00,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44399/tests/dromaeo/cssquery-prototype.html) 18:05:00 INFO - 2015-12-17 18:05:00,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 213889024 18:05:00 INFO - 2015-12-17 18:05:00,902 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-12-17 18:08:03,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44399/tests/dromaeo/cssquery-yui.html) 18:08:04 INFO - 2015-12-17 18:08:04,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 217182208 18:08:04 INFO - 2015-12-17 18:08:04,258 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/dromaeo/cssquery-yui.html (next: http://localhost:44399/tests/dromaeo/cssquery-dojo.html) 18:11:06 INFO - 2015-12-17 18:11:06,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 260423680 18:11:06 INFO - 2015-12-17 18:11:06,899 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,900 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:06 INFO - 2015-12-17 18:11:06,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:06 INFO - 2015-12-17 18:11:06,900 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:06 INFO - 2015-12-17 18:11:06,900 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:06 INFO - 2015-12-17 18:11:06,900 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.4623952089823;2682.8390296582193;2690.1660485249563;2702.18934319704;2702.9324266893336;4482.8879278017985;4617.168909596271;4720.881977950548;4746.549077837604;4757.738324392157;4557.840475583355;4662.557057079572;4676.7193968361835;4698.177818881691;4790.856274311776;4382.846600368987;4405.295152775557;4412.051408947075;4420.491643461011;4442.2004039272915;4207.768572728499;4456.866294011184;4465.665075119363;4508.887277818065;4520.095980803852;4296.806643701041;4329.350597410382;4339.6745244106505;4351.390805287262;4384.978075109636;4343.500497442803;4365.563443655609;4383.8684839454545;4404.031113155101;4426.026274219698;4240.766757828318;4336.934945975813;4349.130173965188;4356.302991521341;4394.209042372372;4589.839355622571;4630.536946305376;4636.652251081148;4773;4794.9280760788615;5079.568236699885;5101.489851014869;5109.054824857413;5114.207297868837;5153.587712982952;4844.830430934936;5143.742812859379;5151.124308867464;5154.587632989352;5164.122099243138;4604.631629469702;4640.466346370143;4658.18481765693;4664.883377915511;4704.388429504211;5236.607254455931;5280.339957505312;5284.550813180846;5288.550473209743;5338.813141540028;4787.40157480315;5063.392392912874;5074.873128171826;5083.87290317745;5128;4947.6289278304275;5005.174146265826;5006.199008158677;5006.3992320921725;5049.697018178921;5042.697438153723;5048.848534543969;5054.646174767731;5057.216131499624;5083.085044691991;4993.051320249141;4994.475580064113;4995.600351971833;4997.900461898376;5037.748112594356;3994.1013272014147;4111.951452379624;4116.444280022219;4219.6202341789385;4257.787110644455;3629.909252268714;3652.086978255436;3677.9264414711556;3687.3178461984617;3718.4794128821986;4305.052888364555;4310.008697999415;4330.2638551446325;4346.2828633275785;4352.303631418958;4817.349657796222;4910.754462276872;4915.65590408668;5018.2974383586325;5049.949500505021;4224.51418086924;4254.957450425518;4312.849050283225;4330.718503297276;4358.476982762026;4460.665450091256;4487.7980490877335;4488.102379524108;4493.236149854467;4526.705764125387;4622.768861556976;4814.1815891297865;4819.060283244734;4820.807167713322;4844.32179494871;4972.2790195422185;4990.6506544541535;5007.924881126859;5036.899262014813;5075.771590278372;4819.397575303087;4846.321514987834;4860.441049279237;4861.9027619448125;4900.583450406755;4809.110314591811;5048.318477005557;5052.065367906949;5057.6459647824295;5104.081265372269;4974.626902982363;4987.650864439454;5064.139096353702;5197.584193264605;5199.896002080013;4978.576820970258;4987.077390682735;4991.775370108281;5000.324956130876;5033.194688849767;4681.953180468152;4970.9254361183885;4987.551120399036;4991.126552853309;4991.450940396626;4695.906081878275;4727.952720472751;4747.62019038483;4790.233562629963;4803.159447096674;4987.750612469435;4996.925046124384;5005.424376196784;5005.599552035901;5052.797888084582;4674.92987605193;4859.611231101433;4889.755512224303;4894.19245824435;4942.085714142895 18:11:06 INFO - 2015-12-17 18:11:06,901 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.3334731627414;557.9414161513041;558.0540983033759;582.0745015425474;583.2243116654847;26697.866510667445;27322.180334589946;33547.16132096696;34100.317993640114;34315.82842085786;39279.41080883782;39830.40254396179;39889.202215955665;39945;39982.60017399825;6859.5541289816;7852.214778522145;8008.479448835807;8024.959875200616;8036.27673509384;7004.544704594211;10067.345622534549;10357.689269321894;10366.274360794747;10368;9981.351212171221;10080.445575493344;10088.596456141782;10090.949545252264;10118.089371956523;7088.68100935454;7307.634618269119;9964.601415943354;10077.798444031077;10140.391576505433;9856.605735770561;10069.09378155962;10079.244056695778;10080.294379393445;10089.848652270222;36813;36819.447708284395;37018.62981370179;37117.62882371169;37176.62823371759;2741.684706258786;2813.0998080614213;3185.378851124032;3255.690709382605;3335.366280406715;28220.858895705594;28388.148355549365;28443.146705598865;28555.571666424814;28563.143105706655;3406.267652454709;3450.292689998544;3459.2562599041075;3526.8589256429714;3540.13266749648;222793.88603057043;223465;224727;226324;226430;54986.45013549813;55282.17076743852;55403.72298138564;55567.44432555704;55579.166312505346;49160.75419622951;51130.488695113316;64606.35393646004;66598;66694.33305666881;12596.118271721074;12691.49234030647;12751.553695620794;12790.9360453199;12810.9359453204;9939.155171810333;10071.143952764098;10083.798324033478;10091.798164036825;10099.848502272473;18627.441176764718;18735.063246837602;18771.0614469276;18822.435326940213;18878.150483228288;7088;7325.597092159983;7409.962950185214;7460.888086678704;7469.551826890295;874.2656168818096;923.4459324405437;972.9880923839128;976.6776963601994;1087.152021423291;25431.745682542936;26046;26468.205953821416;26502.46995060088;26574.734252657614;986.9703908882746;996.3025881882711;997.0478193325501;1031.8606988056667;1047.9738006549896;13157.407916643773;13827.861721382658;14232.408050311928;14547.78178327326;14673.633159170893;263241;264929;265820;265826;266093;45942.540574593826;46090;46158.538414615425;46243.76878115655;46257.768711156226;1231.1012960538858;1236.8082947143207;1245.9252444853337;1251.1867286263819;1260.8991280697521;25986.35034124162;26502.734972650025;26762.59856102199;27016;27036.864815675795;35116.64883351236;35974.46038309375;36035.63964360323;40823.38764918588;42038.36942445927;199330;200347;201493;203102;203947;27119.86440067866;27502.44995100127;27538;27603.171904842886;27613.447731045668;29974.550381744728;32600;33052.504212437314;37273.068173295884;38078.42882356711;27058.864705676344;28097.297567560974;28194.577081344207;28253.43493130167;28562.285942851595;28134.85932570324;28301.858490707415;28327.29181770472;28606;28637.856810715813;28708.712912870604;28931.855340723163;28962.710372896843;29230.26924326909;30814.229644259074;25950.74049259559;27484.312892177055;28296.85851570729;28825.423491529633;29075.85462072761;22397;22400.551988960455;22417.43956401103;22625.660615091118;22672.659910101032 18:11:06 INFO - 2015-12-17 18:11:06,902 DEBUG : BROWSER_OUTPUT: |2;jquery.html;318.37598307317654;323.90816366715234;324.1879092872354;324.27039161885756;330.20256081563025;12519.12366134371;12843.229406235609;15202.391904323827;15470;15589.142597157166;12203.084768642342;14875.702485950274;14934.775978360334;15305.84694153058;15348.232588370593;4782.713037217769;4814.7833347499445;4913.434954980187;4920.360353154085;4971.353724015873;3658.579263384718;3745;4836.46798852126;4874.610031197513;5412.404635490093;5601.215829783833;5618.129189975561;5633.63381380209;5649.604527683064;5656.490915817576;5468.26178465908;5577.414371490976;5615.241942337773;5620.044592419257;5623.465770751772;5045.217991211368;5047.798088076509;5055;5059.721715305656;5064.215046667772;19085.713714294296;19250.22999080035;19489;20369.796302037088;20372.083256253503;1807.493901707524;1830.4417152768401;1857.6841936870765;1909.3699079303797;2023.8380929525604;11365.204435689506;11444.71388215293;11953.163278570504;12614.117011809178;12655.303958282291;1729.550316917598;1741.451442795528;1750.2561411400104;1810.7958207791803;1831.0478551153458;51460.74269628628;54030.18954715682;55107.44892551103;55188.620284492405;55815.720921395536;9089.27285817133;9286.814263714688;9526.333156679104;9541.570629321697;9586.089321514444;12065.517379304905;12123.151379403356;12124.69688257783;12150.817737733942;12166;7061.646917654097;7063.5761854287875;7105.573665579978;7113.679884405111;7114.14630244374;6820.761273355409;6836.658167091626;6841.62371069586;6890.44876409886;6897.41371983377;5771.220885180531;5804.303483581997;5811.82564523065;5826.329972053268;5839.708014599253;1517.9392824287127;1575.7478803391632;1591.2521115075897;1592.9044257344597;1597.5686564627485;843.9367047471465;859.4198915731856;872.3718922375879;955.2596737528471;969.7672558585889;15045.623859403602;15151.242437878062;15616.141112238709;15835.604109897346;15902.443414480438;740.3521918321469;788.4717239449583;833.2792134803473;871.9171678690515;944.5230158769915;8914.598843052077;8989.41568798039;9123.133302336268;9190.49452280131;9556.952215239018;447678;460600;468059;477715;479633;62441;64110.679446602466;64668.353316467175;64684.35315646877;65895.67052164709;441.92266353388027;456.8926302318952;458.02669327678683;458.77749291594216;460.07984031936127;9126.543672816466;9225.400348977295;9498;9560.139587437165;9860.704178874645;32487.18782030468;32863.835680821445;33644.32711345809;34062.14844628805;34173;42546.36180457358;43175.35236971511;43779.90550236142;44802.55197447984;45345;8644.308455323684;9103.408278461879;9129.680461183827;9135.77160570991;9149.86275205859;16267.186640668157;16647.66704665924;16660.333586656398;16785.244663989906;16800.747988780422;13868.722625547634;14000.509982150576;14080.859191407955;14107.788383174466;14268.072575282573;2201.207565276467;2249.3364457484754;4950.801967921243;13807.447702091804;13920.164790112625;10639.627613033506;11984.101192410779;14047.578572642837;14052;14257.073290236101;8641.395102342776;8695.173958473935;8773.298136148966;8776.692815751418;8964.193222609996;12749.298788566717;12816.295103769382;12977.805332919825;13380.397882095134;13639.727205456034 18:11:06 INFO - 2015-12-17 18:11:06,903 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1270.9491620335186;1623.3587732845526;1692.4161164398279;1693.8136804951457;1725.6721222967635;6321.6523091229965;7106.964465177673;7273.018142550754;7284.198738138807;7293.452991025681;7163.247858974811;7169.46229032822;7246.7825965221;7256.165540962791;7257.27427257274;2006.7090271910529;2034.2778313698645;2034.5015471209574;2035.0435295411207;2037.5517386175018;2075.5122546201633;2097.7063211150453;2110.7150534677776;2145.903434345458;2147.194801949269;2038.3884834549576;2041.3263623004373;2046.9283575074876;2062.804033616804;2066.225165562914;2036.8065033821763;2045.6317862784692;2063.215977928385;2066.3387715930908;2067.3487851326786;2046.1508473983279;2059.104289634014;2095.9790402096087;2097.1716172112083;2099.391176558796;7116.964415177891;7195.352418282379;7202.711891524333;7206.711731530732;7217.314355136254;4183.393407955859;4253.000544871953;4264.296391095466;4270.487541495009;4277.443932288783;2603.075908052633;2621;2631.5000149971443;2698.716634753362;2714.307851497875;874.0298268921492;875.9737207883774;877.1184959116111;879.4459490520995;909.6952520905504;9858.359206651545;9887.159591434665;9934.25493088014;9960.601575936953;10046.547905344203;3751.9249615007548;3782.130110074643;3826.100866296418;3834.7699138051807;3842.9231415371537;8593.828123437495;8695.434796738191;8746.86879696805;8755.036945935943;8771.956140219258;4193.622573968358;4207.116505533811;4208.936865947013;4209.031922657806;4210.136921930997;3216.3084936738715;3248.545203671488;3707.295613833363;3830.8276127574327;3842.634949679832;3359.512870633793;3407.80726745642;3412.658734126617;3456.70617997468;3482.8432720527635;1052.6684094510206;1057.772578895541;1061.6602687140196;1066.6053560182781;1071.3571856885806;912.9908700913039;968.6851773173747;1173.3487914207697;1181.7400171962154;1188.3701638131804;6967.198772141167;7017.087778588751;7022.824429389204;7040.823979400556;7044.366007059287;1119.9160062995309;1122.971925701864;1124.9493772780245;1151.6660168551193;1165.7085728567858;5493.890122197614;5546.805861794898;5556.249906262603;5556.499915007668;5564.360098588633;8664.61009254585;9090.409123406956;9213.12475314844;9213.90786092144;9215.308851836138;9077;9078.636854525745;9085;9085.77285567866;9098.727038188865;6897.7585784497305;6906.620135892575;7072.717091316393;7094.609796461141;7098.609576473344;6728.226253980855;6760;6765.560238584476;6767.086443330088;6775.695093720893;7835.529868207926;8165.183481651788;8170.42807003504;8182.918170818216;8196.262336389753;8141.755747327589;8290.668373265002;8313.625886834985;8432;8433;5004.324416203766;5127.102757017582;5887.61730487517;5896.55775816824;5957.195778570011;6149.108379285068;6190.380961903774;6202.844928876814;6889.552179108342;7045.225025247321;6674.532782705164;6683.097781799589;6688.498362622726;6805.183377994672;6816.079829223189;6476.5466417350335;6481.773137940149;6566.0479230510355;6641.734330626721;6673.9666301668185;6673.866522669617;6707.899381509379;6720.294369091371;6722.495812814156;6728.461723062045;6065.6663883486835;6135.631862088289;6138.631682099089;6198.535109866868;6229.190205273467;6072.635641861502;6102.2067131274425;6105.8168254952425;6115.449609535163;6120.540959427972 18:11:06 INFO - 2015-12-17 18:11:06,904 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.9653889802673;305.50965700051415;306.0939618728564;308.8270568481649;312.92020534763634;5268.73656317184;5345.1982202669615;5406.486383793543;5410.972945135269;5430.049741295267;5292.682439053659;5305.973470132644;5311.389190243123;5314.840554783353;5319.494648008433;3945.191235796669;4180.892063603148;4185.539590645034;4193.391958166064;4195.832166713328;4033.9915021244688;4060.8375664973514;4195.328747400416;4198.769067701275;4208.4318616986775;4136.110736191718;4140.047789008529;4146.834126634931;4155.62599366057;4164.083901541656;3894.7468414553246;3985.242803867256;4021.738586991836;4149.04571948452;4157.91684166318;3666.7983260920637;3675.650813172744;3682.2819550187724;3683.72372072093;3687.520622319108;5143.537081662668;5150.356205474316;5158.767855446514;5164.870878228036;5166.405863325728;4805.327254184417;4811.302361157647;4818.253170758538;4821;4822.831200907952;5490.313710786152;5634.802781902614;5636.351819540723;5647.519960803336;5650.802221922254;3973.3443981742976;3974.3442332015184;3975.403689446577;3978.3634618460906;3978.781167035812;5896.941030589725;5913.319968203668;5913.467787899067;5916.230889984275;5922.555808314393;4091.5499295077516;4096.32410652245;4099.057216840143;4099.467069280974;4100.958990410058;3938.2714197873483;4056.5740597237454;4162.084341444938;4169.228692691861;4171.561985991488;4696;4701.318308845267;4703.435587729426;4704.741239231875;4704.882377940579;5627.184058311522;5637.943620563824;5638.210650508932;5638.802641907513;5639.013172694762;1404.9954282687927;1436.8060311857766;1439.6976634906787;1441.5387076135746;1442.819647544057;936.2463217110292;962.153305091515;968.6319198704588;985.7289245457556;988.8170688422665;4911.017796440726;4913.140200464904;4922.680025798311;4924.8030078797165;4929.482404347492;5855.59010869235;5858.179854820329;5862;5865.648061116347;5867.207926929896;4901.705897646081;4904.215325547966;4912.975435122801;4914.778834952435;4921.064997650435;2896.2614533294295;3036.271294889255;3095.16430563751;3126.515390114536;3168.6989735975044;5500.972495137498;5580.051391263414;5582.441755824385;5586.994341018574;5592.412796656293;6057.757689692363;6063.636181829104;6071.241094863142;6073.635581865102;6076.21009268801;5570.777168913198;5578.41426650204;5588.2455868458865;5590.440955904377;5592.552595792326;5776.205659625482;5888.587798854211;5897.203877476657;5899.882002359843;5901.91147132802;5729.1119876419225;5746.597738158289;5749.223854779551;5750.964826331133;5752.539796816328;5491.341039075336;5531.9723401382735;5539.91971565557;5543.695096769717;5550;3893.7274390793505;4041.696872734498;4053.067794407244;4053.2704113258715;4057.087155390014;5801.332846722681;5813.593048486566;5865.530757539302;5866.472017518444;5869.7945571904775;5582.358028826737;5614.326280846324;5627.212190293444;5639.943600563942;5643.830685079454;5597.468240517144;5641;5656.038473459439;5656.406077361818;5664.26364572603;5397.78408863641;5510.889782204414;5515;5517.641353312022;5521.282233309644;5661.688607126483;5666.178404131296;5667.291588551431;5672.688002159921;5673.092305231144;5333.626646134889;5454.236406903116;5519.978803921287;5608.495235428831;5612.130119831432 18:11:06 INFO - 2015-12-17 18:11:06,904 DEBUG : BROWSER_OUTPUT: |5;yui.html;656.9770058047966;667.1260648550399;739.4712780362041;745.2137994415891;767.309421520631;9987.750306242348;10144.543495542699;10165.186785057196;10237.334573252743;10412.219083568725;10711.892881071188;10798.838017429745;10801.13590912727;10807;10840.078593319558;629.3423372575646;634.7175506899432;786.6617354537561;789.3211837819471;806.4113197365926;796.2714116583319;796.5300472721093;799.6361655446786;802.9397795165386;803.5018288661038;835.3567752830317;840.0381563110235;841.0160112668193;841.5077179849795;841.8021764885247;650.5218664281749;656.8029591122668;814.4298990706529;826.1119296755951;828.7969447485344;619.6808643548576;620.1287191495956;620.3579295429254;620.5842085802523;621.142822904389;10667.413292268922;10830.296030757976;10840.566377344896;10845.457727113691;10858.457077146111;10862.891371086267;11449;11485;11488.827667584992;11501.30992140466;8666.653333866638;8871.556422178865;8962.103789621051;8973.730788076367;8980.8652870207;3246.5130230465384;3277.8688852445875;3280.950785738216;3286.65490123536;3291.5062740589105;35528.28943421143;36210.456843147374;36661.45007824885;36882.07794805124;36936;7203.747868824566;7473.065866766654;7482.326590606872;7582.431317651198;7591.164971853203;16251.618612418077;16255.51233462998;16263.268152933146;16273.267702953395;16295.755563666316;6125.908111378333;6243.157173781572;6261.592996455216;6348;6374.362563743589;3219.291755813764;3313.7680362374886;3356.697897189216;3380.5267262583257;3431.4338134208074;2362.893669784864;2392.7128744550764;2394.616861302183;2399.808015358767;2401.6757737705534;410.365984553865;419.40235164889907;435.7929983257927;435.8910272431892;436.27795997623986;393.74996876983323;432.71873282366084;454.5227511113318;532.9413764485903;553.7591147850617;7077.433805295667;7115.964420177866;7613.847723045508;7788.493747906368;7949.761507154794;429.0732018839292;471.64626530102424;532.624499727691;574.9741261643236;594.5303210463685;3286.14560214346;3435.7766745161985;3484.8954531364097;3494.790312581253;3586.085548185196;45710.54289457129;46402.76798615985;46453;50481.24278135831;55450.44549554533;40124.799376002935;40230.798846005586;40237.39643905344;40276.59723402787;40664.593354066674;37279.25441491155;38230.42654360187;38429.80785096057;39283.607163928566;39470.605293947265;7290.744823931137;7392.149902761036;7566.35685966699;7681.577513236825;7843.7254696085365;30268;30277;30811.537826932166;30830;30966.22584435407;34088;37316.626833731316;37535;37732;37985.24029519339;9413.52932353366;9664.275179361717;10160.136388406772;10233.13018393415;10276.332038417479;10555.208359372924;10581.206409519471;10582.259241853304;10710.625128120479;10725.463726813472;9977.700668979942;10009.749756256151;10120.848187277345;10257.076863082359;10376.118029967538;9673.177779888789;9887.456189909624;9922.801543969224;10143.34068285559;10224.182065434896;9784.755381115529;9885.159761420073;9936.850947235653;10236.078752912274;10469;8108.635111419882;8374.162583741578;8429.452085614415;8489.74530764078;8551.10213427606;7795.610219488889;8045.436819422584;8218.21926916942;8230.753077407688;8456.661733530836 18:11:06 INFO - 2015-12-17 18:11:06,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:06 INFO - 2015-12-17 18:11:06,904 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:11:06 INFO - 2015-12-17 18:11:06,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 18:11:06 INFO - 2015-12-17 18:11:06,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:11:06 INFO - 2015-12-17 18:11:06,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404666898__endTimestamp 18:11:06 INFO - 2015-12-17 18:11:06,905 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,905 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:06 INFO - 2015-12-17 18:11:06,906 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:11:06 INFO - 2015-12-17 18:11:06,906 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,906 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4667.11 Median:4794.93 stddev:500.35 (10.4%) stddev-sans-first:475.49 18:11:06 INFO - 2015-12-17 18:11:06,906 DEBUG : BROWSER_OUTPUT: Values: 2622.5 2682.8 2690.2 2702.2 2702.9 4482.9 4617.2 4720.9 4746.5 4757.7 4557.8 4662.6 4676.7 4698.2 4790.9 4382.8 4405.3 4412.1 4420.5 4442.2 4207.8 4456.9 4465.7 4508.9 4520.1 4296.8 4329.4 4339.7 4351.4 4385.0 4343.5 4365.6 4383.9 4404.0 4426.0 4240.8 4336.9 4349.1 4356.3 4394.2 4589.8 4630.5 4636.7 4773.0 4794.9 5079.6 5101.5 5109.1 5114.2 5153.6 4844.8 5143.7 5151.1 5154.6 5164.1 4604.6 4640.5 4658.2 4664.9 4704.4 5236.6 5280.3 5284.6 5288.6 5338.8 4787.4 5063.4 5074.9 5083.9 5128.0 4947.6 5005.2 5006.2 5006.4 5049.7 5042.7 5048.8 5054.6 5057.2 5083.1 4993.1 4994.5 4995.6 4997.9 5037.7 3994.1 4112.0 4116.4 4219.6 4257.8 3629.9 3652.1 3677.9 3687.3 3718.5 4305.1 4310.0 4330.3 4346.3 4352.3 4817.3 4910.8 4915.7 5018.3 5049.9 4224.5 4255.0 4312.8 4330.7 4358.5 4460.7 4487.8 4488.1 4493.2 4526.7 4622.8 4814.2 4819.1 4820.8 4844.3 4972.3 4990.7 5007.9 5036.9 5075.8 4819.4 4846.3 4860.4 4861.9 4900.6 4809.1 5048.3 5052.1 5057.6 5104.1 4974.6 4987.7 5064.1 5197.6 5199.9 4978.6 4987.1 4991.8 5000.3 5033.2 4682.0 4970.9 4987.6 4991.1 4991.5 4695.9 4728.0 4747.6 4790.2 4803.2 4987.8 4996.9 5005.4 5005.6 5052.8 4674.9 4859.6 4889.8 4894.2 4942.1 18:11:06 INFO - 2015-12-17 18:11:06,906 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,907 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38821.73 Median:28357.72 stddev:60411.94 (213.0%) stddev-sans-first:60513.05 18:11:06 INFO - 2015-12-17 18:11:06,907 DEBUG : BROWSER_OUTPUT: Values: 546.3 557.9 558.1 582.1 583.2 26697.9 27322.2 33547.2 34100.3 34315.8 39279.4 39830.4 39889.2 39945.0 39982.6 6859.6 7852.2 8008.5 8025.0 8036.3 7004.5 10067.3 10357.7 10366.3 10368.0 9981.4 10080.4 10088.6 10090.9 10118.1 7088.7 7307.6 9964.6 10077.8 10140.4 9856.6 10069.1 10079.2 10080.3 10089.8 36813.0 36819.4 37018.6 37117.6 37176.6 2741.7 2813.1 3185.4 3255.7 3335.4 28220.9 28388.1 28443.1 28555.6 28563.1 3406.3 3450.3 3459.3 3526.9 3540.1 222793.9 223465.0 224727.0 226324.0 226430.0 54986.5 55282.2 55403.7 55567.4 55579.2 49160.8 51130.5 64606.4 66598.0 66694.3 12596.1 12691.5 12751.6 12790.9 12810.9 9939.2 10071.1 10083.8 10091.8 10099.8 18627.4 18735.1 18771.1 18822.4 18878.2 7088.0 7325.6 7410.0 7460.9 7469.6 874.3 923.4 973.0 976.7 1087.2 25431.7 26046.0 26468.2 26502.5 26574.7 987.0 996.3 997.0 1031.9 1048.0 13157.4 13827.9 14232.4 14547.8 14673.6 263241.0 264929.0 265820.0 265826.0 266093.0 45942.5 46090.0 46158.5 46243.8 46257.8 1231.1 1236.8 1245.9 1251.2 1260.9 25986.4 26502.7 26762.6 27016.0 27036.9 35116.6 35974.5 36035.6 40823.4 42038.4 199330.0 200347.0 201493.0 203102.0 203947.0 27119.9 27502.4 27538.0 27603.2 27613.4 29974.6 32600.0 33052.5 37273.1 38078.4 27058.9 28097.3 28194.6 28253.4 28562.3 28134.9 28301.9 28327.3 28606.0 28637.9 28708.7 28931.9 28962.7 29230.3 30814.2 25950.7 27484.3 28296.9 28825.4 29075.9 22397.0 22400.6 22417.4 22625.7 22672.7 18:11:06 INFO - 2015-12-17 18:11:06,907 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,907 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25394.98 Median:459.43 stddev:76196.02 (16585.0%) stddev-sans-first:76386.50 18:11:06 INFO - 2015-12-17 18:11:06,908 DEBUG : BROWSER_OUTPUT: Values: 318.4 323.9 324.2 324.3 330.2 12519.1 12843.2 15202.4 15470.0 15589.1 12203.1 14875.7 14934.8 15305.8 15348.2 4782.7 4814.8 4913.4 4920.4 4971.4 3658.6 3745.0 4836.5 4874.6 5412.4 5601.2 5618.1 5633.6 5649.6 5656.5 5468.3 5577.4 5615.2 5620.0 5623.5 5045.2 5047.8 5055.0 5059.7 5064.2 19085.7 19250.2 19489.0 20369.8 20372.1 1807.5 1830.4 1857.7 1909.4 2023.8 11365.2 11444.7 11953.2 12614.1 12655.3 1729.6 1741.5 1750.3 1810.8 1831.0 51460.7 54030.2 55107.4 55188.6 55815.7 9089.3 9286.8 9526.3 9541.6 9586.1 12065.5 12123.2 12124.7 12150.8 12166.0 7061.6 7063.6 7105.6 7113.7 7114.1 6820.8 6836.7 6841.6 6890.4 6897.4 5771.2 5804.3 5811.8 5826.3 5839.7 1517.9 1575.7 1591.3 1592.9 1597.6 843.9 859.4 872.4 955.3 969.8 15045.6 15151.2 15616.1 15835.6 15902.4 740.4 788.5 833.3 871.9 944.5 8914.6 8989.4 9123.1 9190.5 9557.0 447678.0 460600.0 468059.0 477715.0 479633.0 62441.0 64110.7 64668.4 64684.4 65895.7 441.9 456.9 458.0 458.8 460.1 9126.5 9225.4 9498.0 9560.1 9860.7 32487.2 32863.8 33644.3 34062.1 34173.0 42546.4 43175.4 43779.9 44802.6 45345.0 8644.3 9103.4 9129.7 9135.8 9149.9 16267.2 16647.7 16660.3 16785.2 16800.7 13868.7 14000.5 14080.9 14107.8 14268.1 2201.2 2249.3 4950.8 13807.4 13920.2 10639.6 11984.1 14047.6 14052.0 14257.1 8641.4 8695.2 8773.3 8776.7 8964.2 12749.3 12816.3 12977.8 13380.4 13639.7 18:11:06 INFO - 2015-12-17 18:11:06,908 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,908 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5094.26 Median:6137.13 stddev:2702.64 (44.0%) stddev-sans-first:2694.94 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: Values: 1270.9 1623.4 1692.4 1693.8 1725.7 6321.7 7107.0 7273.0 7284.2 7293.5 7163.2 7169.5 7246.8 7256.2 7257.3 2006.7 2034.3 2034.5 2035.0 2037.6 2075.5 2097.7 2110.7 2145.9 2147.2 2038.4 2041.3 2046.9 2062.8 2066.2 2036.8 2045.6 2063.2 2066.3 2067.3 2046.2 2059.1 2096.0 2097.2 2099.4 7117.0 7195.4 7202.7 7206.7 7217.3 4183.4 4253.0 4264.3 4270.5 4277.4 2603.1 2621.0 2631.5 2698.7 2714.3 874.0 876.0 877.1 879.4 909.7 9858.4 9887.2 9934.3 9960.6 10046.5 3751.9 3782.1 3826.1 3834.8 3842.9 8593.8 8695.4 8746.9 8755.0 8772.0 4193.6 4207.1 4208.9 4209.0 4210.1 3216.3 3248.5 3707.3 3830.8 3842.6 3359.5 3407.8 3412.7 3456.7 3482.8 1052.7 1057.8 1061.7 1066.6 1071.4 913.0 968.7 1173.3 1181.7 1188.4 6967.2 7017.1 7022.8 7040.8 7044.4 1119.9 1123.0 1124.9 1151.7 1165.7 5493.9 5546.8 5556.2 5556.5 5564.4 8664.6 9090.4 9213.1 9213.9 9215.3 9077.0 9078.6 9085.0 9085.8 9098.7 6897.8 6906.6 7072.7 7094.6 7098.6 6728.2 6760.0 6765.6 6767.1 6775.7 7835.5 8165.2 8170.4 8182.9 8196.3 8141.8 8290.7 8313.6 8432.0 8433.0 5004.3 5127.1 5887.6 5896.6 5957.2 6149.1 6190.4 6202.8 6889.6 7045.2 6674.5 6683.1 6688.5 6805.2 6816.1 6476.5 6481.8 6566.0 6641.7 6674.0 6673.9 6707.9 6720.3 6722.5 6728.5 6065.7 6135.6 6138.6 6198.5 6229.2 6072.6 6102.2 6105.8 6115.4 6120.5 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4679.71 Median:5326.56 stddev:1380.67 (25.9%) stddev-sans-first:1344.86 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: Values: 301.0 305.5 306.1 308.8 312.9 5268.7 5345.2 5406.5 5411.0 5430.0 5292.7 5306.0 5311.4 5314.8 5319.5 3945.2 4180.9 4185.5 4193.4 4195.8 4034.0 4060.8 4195.3 4198.8 4208.4 4136.1 4140.0 4146.8 4155.6 4164.1 3894.7 3985.2 4021.7 4149.0 4157.9 3666.8 3675.7 3682.3 3683.7 3687.5 5143.5 5150.4 5158.8 5164.9 5166.4 4805.3 4811.3 4818.3 4821.0 4822.8 5490.3 5634.8 5636.4 5647.5 5650.8 3973.3 3974.3 3975.4 3978.4 3978.8 5896.9 5913.3 5913.5 5916.2 5922.6 4091.5 4096.3 4099.1 4099.5 4101.0 3938.3 4056.6 4162.1 4169.2 4171.6 4696.0 4701.3 4703.4 4704.7 4704.9 5627.2 5637.9 5638.2 5638.8 5639.0 1405.0 1436.8 1439.7 1441.5 1442.8 936.2 962.2 968.6 985.7 988.8 4911.0 4913.1 4922.7 4924.8 4929.5 5855.6 5858.2 5862.0 5865.6 5867.2 4901.7 4904.2 4913.0 4914.8 4921.1 2896.3 3036.3 3095.2 3126.5 3168.7 5501.0 5580.1 5582.4 5587.0 5592.4 6057.8 6063.6 6071.2 6073.6 6076.2 5570.8 5578.4 5588.2 5590.4 5592.6 5776.2 5888.6 5897.2 5899.9 5901.9 5729.1 5746.6 5749.2 5751.0 5752.5 5491.3 5532.0 5539.9 5543.7 5550.0 3893.7 4041.7 4053.1 4053.3 4057.1 5801.3 5813.6 5865.5 5866.5 5869.8 5582.4 5614.3 5627.2 5639.9 5643.8 5597.5 5641.0 5656.0 5656.4 5664.3 5397.8 5510.9 5515.0 5517.6 5521.3 5661.7 5666.2 5667.3 5672.7 5673.1 5333.6 5454.2 5520.0 5608.5 5612.1 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-17 18:11:06,909 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11514.04 Median:435.84 stddev:13043.11 (2992.6%) stddev-sans-first:13054.21 18:11:06 INFO - 2015-12-17 18:11:06,910 DEBUG : BROWSER_OUTPUT: Values: 657.0 667.1 739.5 745.2 767.3 9987.8 10144.5 10165.2 10237.3 10412.2 10711.9 10798.8 10801.1 10807.0 10840.1 629.3 634.7 786.7 789.3 806.4 796.3 796.5 799.6 802.9 803.5 835.4 840.0 841.0 841.5 841.8 650.5 656.8 814.4 826.1 828.8 619.7 620.1 620.4 620.6 621.1 10667.4 10830.3 10840.6 10845.5 10858.5 10862.9 11449.0 11485.0 11488.8 11501.3 8666.7 8871.6 8962.1 8973.7 8980.9 3246.5 3277.9 3281.0 3286.7 3291.5 35528.3 36210.5 36661.5 36882.1 36936.0 7203.7 7473.1 7482.3 7582.4 7591.2 16251.6 16255.5 16263.3 16273.3 16295.8 6125.9 6243.2 6261.6 6348.0 6374.4 3219.3 3313.8 3356.7 3380.5 3431.4 2362.9 2392.7 2394.6 2399.8 2401.7 410.4 419.4 435.8 435.9 436.3 393.7 432.7 454.5 532.9 553.8 7077.4 7116.0 7613.8 7788.5 7949.8 429.1 471.6 532.6 575.0 594.5 3286.1 3435.8 3484.9 3494.8 3586.1 45710.5 46402.8 46453.0 50481.2 55450.4 40124.8 40230.8 40237.4 40276.6 40664.6 37279.3 38230.4 38429.8 39283.6 39470.6 7290.7 7392.1 7566.4 7681.6 7843.7 30268.0 30277.0 30811.5 30830.0 30966.2 34088.0 37316.6 37535.0 37732.0 37985.2 9413.5 9664.3 10160.1 10233.1 10276.3 10555.2 10581.2 10582.3 10710.6 10725.5 9977.7 10009.7 10120.8 10257.1 10376.1 9673.2 9887.5 9922.8 10143.3 10224.2 9784.8 9885.2 9936.9 10236.1 10469.0 8108.6 8374.2 8429.5 8489.7 8551.1 7795.6 8045.4 8218.2 8230.8 8456.7 18:11:06 INFO - 2015-12-17 18:11:06,910 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:06 INFO - 2015-12-17 18:11:06,910 DEBUG : BROWSER_OUTPUT: 18:11:07 INFO - 2015-12-17 18:11:07,725 INFO : Browser exited with error code: 0 18:11:07 INFO - 2015-12-17 18:11:07,746 INFO : Completed test dromaeo_css (00:18:38) 18:11:07 INFO - 2015-12-17 18:11:07,746 INFO : Starting test kraken 18:11:07 INFO - 2015-12-17 18:11:07,746 DEBUG : operating with platform_type : linux_ 18:11:07 INFO - 2015-12-17 18:11:07,747 INFO : Initialising browser for kraken test... 18:11:07 INFO - 2015-12-17 18:11:07,753 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplGAWy/profile http://localhost:44399/getInfo.html 18:11:12 INFO - 2015-12-17 18:11:12,695 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:11:12 INFO - 2015-12-17 18:11:12,695 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:11:12 INFO - 2015-12-17 18:11:12,695 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:11:12 INFO - 2015-12-17 18:11:12,695 DEBUG : BROWSER_OUTPUT: __metrics 18:11:12 INFO - 2015-12-17 18:11:12,800 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] 18:11:12 INFO - 2015-12-17 18:11:12,862 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] 18:11:13 INFO - 2015-12-17 18:11:13,758 INFO : Browser initialized. 18:11:13 INFO - 2015-12-17 18:11:13,758 INFO : Running cycle 1/1 for kraken test... 18:11:13 INFO - 2015-12-17 18:11:13,759 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplGAWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:11:25 INFO - 2015-12-17 18:11:25,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 149508096 18:11:25 INFO - 2015-12-17 18:11:25,793 DEBUG : BROWSER_OUTPUT: 18:11:28 INFO - 2015-12-17 18:11:28,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44399/tests/kraken/driver.html?testName=audio-beat-detection) 18:11:28 INFO - 2015-12-17 18:11:28,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 183926784 18:11:28 INFO - 2015-12-17 18:11:28,970 DEBUG : BROWSER_OUTPUT: 18:11:31 INFO - 2015-12-17 18:11:31,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44399/tests/kraken/driver.html?testName=audio-dft) 18:11:32 INFO - 2015-12-17 18:11:32,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 174997504 18:11:32 INFO - 2015-12-17 18:11:32,277 DEBUG : BROWSER_OUTPUT: 18:11:35 INFO - 2015-12-17 18:11:35,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44399/tests/kraken/driver.html?testName=audio-fft) 18:11:35 INFO - 2015-12-17 18:11:35,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 160661504 18:11:35 INFO - 2015-12-17 18:11:35,850 DEBUG : BROWSER_OUTPUT: 18:11:37 INFO - 2015-12-17 18:11:37,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44399/tests/kraken/driver.html?testName=audio-oscillator) 18:11:38 INFO - 2015-12-17 18:11:38,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 163983360 18:11:38 INFO - 2015-12-17 18:11:38,446 DEBUG : BROWSER_OUTPUT: 18:11:40 INFO - 2015-12-17 18:11:40,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:11:41 INFO - 2015-12-17 18:11:41,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 165089280 18:11:41 INFO - 2015-12-17 18:11:41,242 DEBUG : BROWSER_OUTPUT: 18:11:44 INFO - 2015-12-17 18:11:44,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44399/tests/kraken/driver.html?testName=imaging-darkroom) 18:11:44 INFO - 2015-12-17 18:11:44,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 164511744 18:11:44 INFO - 2015-12-17 18:11:44,796 DEBUG : BROWSER_OUTPUT: 18:11:48 INFO - 2015-12-17 18:11:48,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44399/tests/kraken/driver.html?testName=imaging-desaturate) 18:11:48 INFO - 2015-12-17 18:11:48,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 165445632 18:11:48 INFO - 2015-12-17 18:11:48,833 DEBUG : BROWSER_OUTPUT: 18:11:51 INFO - 2015-12-17 18:11:51,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44399/tests/kraken/driver.html?testName=json-parse-financial) 18:11:52 INFO - 2015-12-17 18:11:52,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 165416960 18:11:52 INFO - 2015-12-17 18:11:52,278 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-17 18:11:54,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:11:54 INFO - 2015-12-17 18:11:54,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 174751744 18:11:54 INFO - 2015-12-17 18:11:54,659 DEBUG : BROWSER_OUTPUT: 18:11:56 INFO - 2015-12-17 18:11:56,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:11:57 INFO - 2015-12-17 18:11:57,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 175652864 18:11:57 INFO - 2015-12-17 18:11:57,115 DEBUG : BROWSER_OUTPUT: 18:11:59 INFO - 2015-12-17 18:11:59,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:59 INFO - 2015-12-17 18:11:59,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 185233408 18:11:59 INFO - 2015-12-17 18:11:59,834 DEBUG : BROWSER_OUTPUT: 18:12:02 INFO - 2015-12-17 18:12:02,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:12:02 INFO - 2015-12-17 18:12:02,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 190263296 18:12:02 INFO - 2015-12-17 18:12:02,935 DEBUG : BROWSER_OUTPUT: 18:12:05 INFO - 2015-12-17 18:12:05,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:12:06 INFO - 2015-12-17 18:12:06,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 187711488 18:12:06 INFO - 2015-12-17 18:12:06,175 DEBUG : BROWSER_OUTPUT: 18:12:07 INFO - 2015-12-17 18:12:07,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44399/tests/kraken/driver.html?testName=ai-astar) 18:12:08 INFO - 2015-12-17 18:12:08,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 246157312 18:12:08 INFO - 2015-12-17 18:12:08,188 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,191 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;116;108;113;113;113;105;115;113;104 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;128;157;163;135;148;157;129;170;131 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;161;164;162;162;162;163;163 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;80;95;71;71;71;105;91;71 18:12:08 INFO - 2015-12-17 18:12:08,192 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;128;94;95;96;131;95;95;136 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;110;110;111;111 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;148;146;146;147 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;71;71;71;72;80;71;71 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;68;68;68;68;68;67 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;82;84;84;82;83;82;83;84;83 18:12:08 INFO - 2015-12-17 18:12:08,193 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;134;119;119;120;126;135;122;127;123 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;137;150;164;148;137;162;137;142;137 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;70;73;70;69;69;68;70 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404728190__endTimestamp 18:12:08 INFO - 2015-12-17 18:12:08,194 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,198 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:12:08 INFO - 2015-12-17 18:12:08,198 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:12:08 INFO - 2015-12-17 18:12:08,199 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,199 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.10 (3.6%) stddev-sans-first:4.34 18:12:08 INFO - 2015-12-17 18:12:08,199 DEBUG : BROWSER_OUTPUT: Values: 112.0 116.0 108.0 113.0 113.0 113.0 105.0 115.0 113.0 104.0 18:12:08 INFO - 2015-12-17 18:12:08,199 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.50 stddev:15.35 (9.9%) stddev-sans-first:16.08 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: Values: 154.0 128.0 157.0 163.0 135.0 148.0 157.0 129.0 170.0 131.0 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 161.0 164.0 162.0 162.0 162.0 163.0 163.0 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:12.45 (17.1%) stddev-sans-first:13.01 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 80.0 95.0 71.0 71.0 71.0 105.0 91.0 71.0 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,200 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:95.00 stddev:17.83 (18.8%) stddev-sans-first:18.54 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 128.0 94.0 95.0 96.0 131.0 95.0 95.0 136.0 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 111.0 111.0 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 18:12:08 INFO - 2015-12-17 18:12:08,201 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:71.00 stddev:2.81 (4.0%) stddev-sans-first:2.95 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 71.0 71.0 71.0 72.0 80.0 71.0 71.0 18:12:08 INFO - 2015-12-17 18:12:08,202 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.78 (2.1%) stddev-sans-first:0.87 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: Values: 88.0 82.0 84.0 84.0 82.0 83.0 82.0 83.0 84.0 83.0 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.00 stddev:5.74 (4.6%) stddev-sans-first:6.08 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: Values: 126.0 134.0 119.0 119.0 120.0 126.0 135.0 122.0 127.0 123.0 18:12:08 INFO - 2015-12-17 18:12:08,203 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:149.00 stddev:10.30 (6.9%) stddev-sans-first:10.84 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: Values: 150.0 137.0 150.0 164.0 148.0 137.0 162.0 137.0 142.0 137.0 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 73.0 70.0 69.0 69.0 68.0 70.0 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:12:08 INFO - 2015-12-17 18:12:08,204 DEBUG : BROWSER_OUTPUT: 18:12:09 INFO - 2015-12-17 18:12:09,105 INFO : Browser exited with error code: 0 18:12:09 INFO - 2015-12-17 18:12:09,159 INFO : Completed test kraken (00:01:01) 18:12:09 INFO - 2015-12-17 18:12:09,159 INFO : Starting test v8_7 18:12:09 INFO - 2015-12-17 18:12:09,159 DEBUG : operating with platform_type : linux_ 18:12:09 INFO - 2015-12-17 18:12:09,159 INFO : Initialising browser for v8_7 test... 18:12:09 INFO - 2015-12-17 18:12:09,166 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHwiL0W/profile http://localhost:44399/getInfo.html 18:12:13 INFO - 2015-12-17 18:12:13,572 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:12:13 INFO - 2015-12-17 18:12:13,572 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:12:13 INFO - 2015-12-17 18:12:13,572 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:12:13 INFO - 2015-12-17 18:12:13,572 DEBUG : BROWSER_OUTPUT: __metrics 18:12:13 INFO - 2015-12-17 18:12:13,709 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] 18:12:13 INFO - 2015-12-17 18:12:13,773 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] 18:12:15 INFO - 2015-12-17 18:12:15,137 INFO : Browser initialized. 18:12:15 INFO - 2015-12-17 18:12:15,138 INFO : Running cycle 1/1 for v8_7 test... 18:12:15 INFO - 2015-12-17 18:12:15,138 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHwiL0W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:12:27 INFO - 2015-12-17 18:12:27,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 149696512 18:12:27 INFO - 2015-12-17 18:12:27,198 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44399/tests/v8_7/run.html (next: http://localhost:44399/tests/v8_7/run.html) 18:12:48 INFO - 2015-12-17 18:12:48,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 453230592 18:12:48 INFO - 2015-12-17 18:12:48,859 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,859 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:12:48 INFO - 2015-12-17 18:12:48,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:12:48 INFO - 2015-12-17 18:12:48,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |0;Richards;165.18004625041294 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.9427296392711 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1974.3589743589744 18:12:48 INFO - 2015-12-17 18:12:48,860 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: |6;Boyer;11882.35294117647 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: |7;RegExp;27405.405405405407 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: |8;Splay;616.0440906307409 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:12:48 INFO - 2015-12-17 18:12:48,861 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404768858__endTimestamp 18:12:48 INFO - 2015-12-17 18:12:48,862 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:12:48 INFO - 2015-12-17 18:12:48,862 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:12:48 INFO - 2015-12-17 18:12:48,862 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,862 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.18 Median:165.18 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: Values: 165.2 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.94 Median:185.94 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: Values: 185.9 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,864 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: Values: 277.9 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: Values: 5181.3 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: Values: 1974.4 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: Values: 793.7 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11882.35 Median:11882.35 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,865 DEBUG : BROWSER_OUTPUT: Values: 11882.4 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27405.41 Median:27405.41 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: Values: 27405.4 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.04 Median:616.04 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: Values: 616.0 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: Values: 4835.7 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:12:48 INFO - 2015-12-17 18:12:48,866 DEBUG : BROWSER_OUTPUT: 18:12:49 INFO - 2015-12-17 18:12:49,849 INFO : Browser exited with error code: 0 18:12:49 INFO - 2015-12-17 18:12:49,864 INFO : Completed test v8_7 (00:00:40) 18:12:49 INFO - 2015-12-17 18:12:49,891 INFO : Completed test suite (00:20:20) 18:12:49 INFO - 2015-12-17 18:12:49,891 DEBUG : Working with test: dromaeo_css 18:12:49 INFO - 2015-12-17 18:12:49,891 DEBUG : Generating results file: dromaeo_css 18:12:49 INFO - 2015-12-17 18:12:49,892 DEBUG : Working with test: kraken 18:12:49 INFO - 2015-12-17 18:12:49,892 DEBUG : Generating results file: kraken 18:12:49 INFO - 2015-12-17 18:12:49,893 INFO : javascript benchmark 18:12:49 INFO - 2015-12-17 18:12:49,893 DEBUG : Working with test: v8_7 18:12:49 INFO - 2015-12-17 18:12:49,893 DEBUG : Generating results file: v8_7 18:12:49 INFO - 2015-12-17 18:12:49,893 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:12:49 INFO - 2015-12-17 18:12:49,948 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:12:49 INFO - 2015-12-17 18:12:49,948 DEBUG : process_Request line: dromaeo_css 6226.39 graph.html#tests=[[72,132,35]] 18:12:49 INFO - 2015-12-17 18:12:49,948 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:12:49 INFO - 2015-12-17 18:12:49,976 DEBUG : process_Request line: kraken 1523.50 graph.html#tests=[[232,132,35]] 18:12:49 INFO - 2015-12-17 18:12:49,976 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:12:50 INFO - 2015-12-17 18:12:50,005 DEBUG : process_Request line: v8_7 19801.30 graph.html#tests=[[230,132,35]] 18:12:50 INFO - 2015-12-17 18:12:50,006 INFO : javascript benchmark 18:12:50 INFO - 2015-12-17 18:12:50,010 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.4623952089823, 2682.8390296582193, 2690.1660485249563, 2702.18934319704, 2702.9324266893336, 4482.8879278017985, 4617.168909596271, 4720.881977950548, 4746.549077837604, 4757.738324392157, 4557.840475583355, 4662.557057079572, 4676.7193968361835, 4698.177818881691, 4790.856274311776, 4382.846600368987, 4405.295152775557, 4412.051408947075, 4420.491643461011, 4442.2004039272915, 4207.768572728499, 4456.866294011184, 4465.665075119363, 4508.887277818065, 4520.095980803852, 4296.806643701041, 4329.350597410382, 4339.6745244106505, 4351.390805287262, 4384.978075109636, 4343.500497442803, 4365.563443655609, 4383.8684839454545, 4404.031113155101, 4426.026274219698, 4240.766757828318, 4336.934945975813, 4349.130173965188, 4356.302991521341, 4394.209042372372, 4589.839355622571, 4630.536946305376, 4636.652251081148, 4773.0, 4794.9280760788615, 5079.568236699885, 5101.489851014869, 5109.054824857413, 5114.207297868837, 5153.587712982952, 4844.830430934936, 5143.742812859379, 5151.124308867464, 5154.587632989352, 5164.122099243138, 4604.631629469702, 4640.466346370143, 4658.18481765693, 4664.883377915511, 4704.388429504211, 5236.607254455931, 5280.339957505312, 5284.550813180846, 5288.550473209743, 5338.813141540028, 4787.40157480315, 5063.392392912874, 5074.873128171826, 5083.87290317745, 5128.0, 4947.6289278304275, 5005.174146265826, 5006.199008158677, 5006.3992320921725, 5049.697018178921, 5042.697438153723, 5048.848534543969, 5054.646174767731, 5057.216131499624, 5083.085044691991, 4993.051320249141, 4994.475580064113, 4995.600351971833, 4997.900461898376, 5037.748112594356, 3994.1013272014147, 4111.951452379624, 4116.444280022219, 4219.6202341789385, 4257.787110644455, 3629.909252268714, 3652.086978255436, 3677.9264414711556, 3687.3178461984617, 3718.4794128821986, 4305.052888364555, 4310.008697999415, 4330.2638551446325, 4346.2828633275785, 4352.303631418958, 4817.349657796222, 4910.754462276872, 4915.65590408668, 5018.2974383586325, 5049.949500505021, 4224.51418086924, 4254.957450425518, 4312.849050283225, 4330.718503297276, 4358.476982762026, 4460.665450091256, 4487.7980490877335, 4488.102379524108, 4493.236149854467, 4526.705764125387, 4622.768861556976, 4814.1815891297865, 4819.060283244734, 4820.807167713322, 4844.32179494871, 4972.2790195422185, 4990.6506544541535, 5007.924881126859, 5036.899262014813, 5075.771590278372, 4819.397575303087, 4846.321514987834, 4860.441049279237, 4861.9027619448125, 4900.583450406755, 4809.110314591811, 5048.318477005557, 5052.065367906949, 5057.6459647824295, 5104.081265372269, 4974.626902982363, 4987.650864439454, 5064.139096353702, 5197.584193264605, 5199.896002080013, 4978.576820970258, 4987.077390682735, 4991.775370108281, 5000.324956130876, 5033.194688849767, 4681.953180468152, 4970.9254361183885, 4987.551120399036, 4991.126552853309, 4991.450940396626, 4695.906081878275, 4727.952720472751, 4747.62019038483, 4790.233562629963, 4803.159447096674, 4987.750612469435, 4996.925046124384, 5005.424376196784, 5005.599552035901, 5052.797888084582, 4674.92987605193, 4859.611231101433, 4889.755512224303, 4894.19245824435, 4942.085714142895], "unit": "score", "name": "dojo.html", "value": 4635.294129568267}, {"lowerIsBetter": false, "replicates": [546.3334731627414, 557.9414161513041, 558.0540983033759, 582.0745015425474, 583.2243116654847, 26697.866510667445, 27322.180334589946, 33547.16132096696, 34100.317993640114, 34315.82842085786, 39279.41080883782, 39830.40254396179, 39889.202215955665, 39945.0, 39982.60017399825, 6859.5541289816, 7852.214778522145, 8008.479448835807, 8024.959875200616, 8036.27673509384, 7004.544704594211, 10067.345622534549, 10357.689269321894, 10366.274360794747, 10368.0, 9981.351212171221, 10080.445575493344, 10088.596456141782, 10090.949545252264, 10118.089371956523, 7088.68100935454, 7307.634618269119, 9964.601415943354, 10077.798444031077, 10140.391576505433, 9856.605735770561, 10069.09378155962, 10079.244056695778, 10080.294379393445, 10089.848652270222, 36813.0, 36819.447708284395, 37018.62981370179, 37117.62882371169, 37176.62823371759, 2741.684706258786, 2813.0998080614213, 3185.378851124032, 3255.690709382605, 3335.366280406715, 28220.858895705594, 28388.148355549365, 28443.146705598865, 28555.571666424814, 28563.143105706655, 3406.267652454709, 3450.292689998544, 3459.2562599041075, 3526.8589256429714, 3540.13266749648, 222793.88603057043, 223465.0, 224727.0, 226324.0, 226430.0, 54986.45013549813, 55282.17076743852, 55403.72298138564, 55567.44432555704, 55579.166312505346, 49160.75419622951, 51130.488695113316, 64606.35393646004, 66598.0, 66694.33305666881, 12596.118271721074, 12691.49234030647, 12751.553695620794, 12790.9360453199, 12810.9359453204, 9939.155171810333, 10071.143952764098, 10083.798324033478, 10091.798164036825, 10099.848502272473, 18627.441176764718, 18735.063246837602, 18771.0614469276, 18822.435326940213, 18878.150483228288, 7088.0, 7325.597092159983, 7409.962950185214, 7460.888086678704, 7469.551826890295, 874.2656168818096, 923.4459324405437, 972.9880923839128, 976.6776963601994, 1087.152021423291, 25431.745682542936, 26046.0, 26468.205953821416, 26502.46995060088, 26574.734252657614, 986.9703908882746, 996.3025881882711, 997.0478193325501, 1031.8606988056667, 1047.9738006549896, 13157.407916643773, 13827.861721382658, 14232.408050311928, 14547.78178327326, 14673.633159170893, 263241.0, 264929.0, 265820.0, 265826.0, 266093.0, 45942.540574593826, 46090.0, 46158.538414615425, 46243.76878115655, 46257.768711156226, 1231.1012960538858, 1236.8082947143207, 1245.9252444853337, 1251.1867286263819, 1260.8991280697521, 25986.35034124162, 26502.734972650025, 26762.59856102199, 27016.0, 27036.864815675795, 35116.64883351236, 35974.46038309375, 36035.63964360323, 40823.38764918588, 42038.36942445927, 199330.0, 200347.0, 201493.0, 203102.0, 203947.0, 27119.86440067866, 27502.44995100127, 27538.0, 27603.171904842886, 27613.447731045668, 29974.550381744728, 32600.0, 33052.504212437314, 37273.068173295884, 38078.42882356711, 27058.864705676344, 28097.297567560974, 28194.577081344207, 28253.43493130167, 28562.285942851595, 28134.85932570324, 28301.858490707415, 28327.29181770472, 28606.0, 28637.856810715813, 28708.712912870604, 28931.855340723163, 28962.710372896843, 29230.26924326909, 30814.229644259074, 25950.74049259559, 27484.312892177055, 28296.85851570729, 28825.423491529633, 29075.85462072761, 22397.0, 22400.551988960455, 22417.43956401103, 22625.660615091118, 22672.659910101032], "unit": "score", "name": "ext.html", "value": 16717.210414904224}, {"lowerIsBetter": false, "replicates": [318.37598307317654, 323.90816366715234, 324.1879092872354, 324.27039161885756, 330.20256081563025, 12519.12366134371, 12843.229406235609, 15202.391904323827, 15470.0, 15589.142597157166, 12203.084768642342, 14875.702485950274, 14934.775978360334, 15305.84694153058, 15348.232588370593, 4782.713037217769, 4814.7833347499445, 4913.434954980187, 4920.360353154085, 4971.353724015873, 3658.579263384718, 3745.0, 4836.46798852126, 4874.610031197513, 5412.404635490093, 5601.215829783833, 5618.129189975561, 5633.63381380209, 5649.604527683064, 5656.490915817576, 5468.26178465908, 5577.414371490976, 5615.241942337773, 5620.044592419257, 5623.465770751772, 5045.217991211368, 5047.798088076509, 5055.0, 5059.721715305656, 5064.215046667772, 19085.713714294296, 19250.22999080035, 19489.0, 20369.796302037088, 20372.083256253503, 1807.493901707524, 1830.4417152768401, 1857.6841936870765, 1909.3699079303797, 2023.8380929525604, 11365.204435689506, 11444.71388215293, 11953.163278570504, 12614.117011809178, 12655.303958282291, 1729.550316917598, 1741.451442795528, 1750.2561411400104, 1810.7958207791803, 1831.0478551153458, 51460.74269628628, 54030.18954715682, 55107.44892551103, 55188.620284492405, 55815.720921395536, 9089.27285817133, 9286.814263714688, 9526.333156679104, 9541.570629321697, 9586.089321514444, 12065.517379304905, 12123.151379403356, 12124.69688257783, 12150.817737733942, 12166.0, 7061.646917654097, 7063.5761854287875, 7105.573665579978, 7113.679884405111, 7114.14630244374, 6820.761273355409, 6836.658167091626, 6841.62371069586, 6890.44876409886, 6897.41371983377, 5771.220885180531, 5804.303483581997, 5811.82564523065, 5826.329972053268, 5839.708014599253, 1517.9392824287127, 1575.7478803391632, 1591.2521115075897, 1592.9044257344597, 1597.5686564627485, 843.9367047471465, 859.4198915731856, 872.3718922375879, 955.2596737528471, 969.7672558585889, 15045.623859403602, 15151.242437878062, 15616.141112238709, 15835.604109897346, 15902.443414480438, 740.3521918321469, 788.4717239449583, 833.2792134803473, 871.9171678690515, 944.5230158769915, 8914.598843052077, 8989.41568798039, 9123.133302336268, 9190.49452280131, 9556.952215239018, 447678.0, 460600.0, 468059.0, 477715.0, 479633.0, 62441.0, 64110.679446602466, 64668.353316467175, 64684.35315646877, 65895.67052164709, 441.92266353388027, 456.8926302318952, 458.02669327678683, 458.77749291594216, 460.07984031936127, 9126.543672816466, 9225.400348977295, 9498.0, 9560.139587437165, 9860.704178874645, 32487.18782030468, 32863.835680821445, 33644.32711345809, 34062.14844628805, 34173.0, 42546.36180457358, 43175.35236971511, 43779.90550236142, 44802.55197447984, 45345.0, 8644.308455323684, 9103.408278461879, 9129.680461183827, 9135.77160570991, 9149.86275205859, 16267.186640668157, 16647.66704665924, 16660.333586656398, 16785.244663989906, 16800.747988780422, 13868.722625547634, 14000.509982150576, 14080.859191407955, 14107.788383174466, 14268.072575282573, 2201.207565276467, 2249.3364457484754, 4950.801967921243, 13807.447702091804, 13920.164790112625, 10639.627613033506, 11984.101192410779, 14047.578572642837, 14052.0, 14257.073290236101, 8641.395102342776, 8695.173958473935, 8773.298136148966, 8776.692815751418, 8964.193222609996, 12749.298788566717, 12816.295103769382, 12977.805332919825, 13380.397882095134, 13639.727205456034], "unit": "score", "name": "jquery.html", "value": 7939.21646861207}, {"lowerIsBetter": false, "replicates": [1270.9491620335186, 1623.3587732845526, 1692.4161164398279, 1693.8136804951457, 1725.6721222967635, 6321.6523091229965, 7106.964465177673, 7273.018142550754, 7284.198738138807, 7293.452991025681, 7163.247858974811, 7169.46229032822, 7246.7825965221, 7256.165540962791, 7257.27427257274, 2006.7090271910529, 2034.2778313698645, 2034.5015471209574, 2035.0435295411207, 2037.5517386175018, 2075.5122546201633, 2097.7063211150453, 2110.7150534677776, 2145.903434345458, 2147.194801949269, 2038.3884834549576, 2041.3263623004373, 2046.9283575074876, 2062.804033616804, 2066.225165562914, 2036.8065033821763, 2045.6317862784692, 2063.215977928385, 2066.3387715930908, 2067.3487851326786, 2046.1508473983279, 2059.104289634014, 2095.9790402096087, 2097.1716172112083, 2099.391176558796, 7116.964415177891, 7195.352418282379, 7202.711891524333, 7206.711731530732, 7217.314355136254, 4183.393407955859, 4253.000544871953, 4264.296391095466, 4270.487541495009, 4277.443932288783, 2603.075908052633, 2621.0, 2631.5000149971443, 2698.716634753362, 2714.307851497875, 874.0298268921492, 875.9737207883774, 877.1184959116111, 879.4459490520995, 909.6952520905504, 9858.359206651545, 9887.159591434665, 9934.25493088014, 9960.601575936953, 10046.547905344203, 3751.9249615007548, 3782.130110074643, 3826.100866296418, 3834.7699138051807, 3842.9231415371537, 8593.828123437495, 8695.434796738191, 8746.86879696805, 8755.036945935943, 8771.956140219258, 4193.622573968358, 4207.116505533811, 4208.936865947013, 4209.031922657806, 4210.136921930997, 3216.3084936738715, 3248.545203671488, 3707.295613833363, 3830.8276127574327, 3842.634949679832, 3359.512870633793, 3407.80726745642, 3412.658734126617, 3456.70617997468, 3482.8432720527635, 1052.6684094510206, 1057.772578895541, 1061.6602687140196, 1066.6053560182781, 1071.3571856885806, 912.9908700913039, 968.6851773173747, 1173.3487914207697, 1181.7400171962154, 1188.3701638131804, 6967.198772141167, 7017.087778588751, 7022.824429389204, 7040.823979400556, 7044.366007059287, 1119.9160062995309, 1122.971925701864, 1124.9493772780245, 1151.6660168551193, 1165.7085728567858, 5493.890122197614, 5546.805861794898, 5556.249906262603, 5556.499915007668, 5564.360098588633, 8664.61009254585, 9090.409123406956, 9213.12475314844, 9213.90786092144, 9215.308851836138, 9077.0, 9078.636854525745, 9085.0, 9085.77285567866, 9098.727038188865, 6897.7585784497305, 6906.620135892575, 7072.717091316393, 7094.609796461141, 7098.609576473344, 6728.226253980855, 6760.0, 6765.560238584476, 6767.086443330088, 6775.695093720893, 7835.529868207926, 8165.183481651788, 8170.42807003504, 8182.918170818216, 8196.262336389753, 8141.755747327589, 8290.668373265002, 8313.625886834985, 8432.0, 8433.0, 5004.324416203766, 5127.102757017582, 5887.61730487517, 5896.55775816824, 5957.195778570011, 6149.108379285068, 6190.380961903774, 6202.844928876814, 6889.552179108342, 7045.225025247321, 6674.532782705164, 6683.097781799589, 6688.498362622726, 6805.183377994672, 6816.079829223189, 6476.5466417350335, 6481.773137940149, 6566.0479230510355, 6641.734330626721, 6673.9666301668185, 6673.866522669617, 6707.899381509379, 6720.294369091371, 6722.495812814156, 6728.461723062045, 6065.6663883486835, 6135.631862088289, 6138.631682099089, 6198.535109866868, 6229.190205273467, 6072.635641861502, 6102.2067131274425, 6105.8168254952425, 6115.449609535163, 6120.540959427972], "unit": "score", "name": "mootools.html", "value": 4165.275493754706}, {"lowerIsBetter": false, "replicates": [300.9653889802673, 305.50965700051415, 306.0939618728564, 308.8270568481649, 312.92020534763634, 5268.73656317184, 5345.1982202669615, 5406.486383793543, 5410.972945135269, 5430.049741295267, 5292.682439053659, 5305.973470132644, 5311.389190243123, 5314.840554783353, 5319.494648008433, 3945.191235796669, 4180.892063603148, 4185.539590645034, 4193.391958166064, 4195.832166713328, 4033.9915021244688, 4060.8375664973514, 4195.328747400416, 4198.769067701275, 4208.4318616986775, 4136.110736191718, 4140.047789008529, 4146.834126634931, 4155.62599366057, 4164.083901541656, 3894.7468414553246, 3985.242803867256, 4021.738586991836, 4149.04571948452, 4157.91684166318, 3666.7983260920637, 3675.650813172744, 3682.2819550187724, 3683.72372072093, 3687.520622319108, 5143.537081662668, 5150.356205474316, 5158.767855446514, 5164.870878228036, 5166.405863325728, 4805.327254184417, 4811.302361157647, 4818.253170758538, 4821.0, 4822.831200907952, 5490.313710786152, 5634.802781902614, 5636.351819540723, 5647.519960803336, 5650.802221922254, 3973.3443981742976, 3974.3442332015184, 3975.403689446577, 3978.3634618460906, 3978.781167035812, 5896.941030589725, 5913.319968203668, 5913.467787899067, 5916.230889984275, 5922.555808314393, 4091.5499295077516, 4096.32410652245, 4099.057216840143, 4099.467069280974, 4100.958990410058, 3938.2714197873483, 4056.5740597237454, 4162.084341444938, 4169.228692691861, 4171.561985991488, 4696.0, 4701.318308845267, 4703.435587729426, 4704.741239231875, 4704.882377940579, 5627.184058311522, 5637.943620563824, 5638.210650508932, 5638.802641907513, 5639.013172694762, 1404.9954282687927, 1436.8060311857766, 1439.6976634906787, 1441.5387076135746, 1442.819647544057, 936.2463217110292, 962.153305091515, 968.6319198704588, 985.7289245457556, 988.8170688422665, 4911.017796440726, 4913.140200464904, 4922.680025798311, 4924.8030078797165, 4929.482404347492, 5855.59010869235, 5858.179854820329, 5862.0, 5865.648061116347, 5867.207926929896, 4901.705897646081, 4904.215325547966, 4912.975435122801, 4914.778834952435, 4921.064997650435, 2896.2614533294295, 3036.271294889255, 3095.16430563751, 3126.515390114536, 3168.6989735975044, 5500.972495137498, 5580.051391263414, 5582.441755824385, 5586.994341018574, 5592.412796656293, 6057.757689692363, 6063.636181829104, 6071.241094863142, 6073.635581865102, 6076.21009268801, 5570.777168913198, 5578.41426650204, 5588.2455868458865, 5590.440955904377, 5592.552595792326, 5776.205659625482, 5888.587798854211, 5897.203877476657, 5899.882002359843, 5901.91147132802, 5729.1119876419225, 5746.597738158289, 5749.223854779551, 5750.964826331133, 5752.539796816328, 5491.341039075336, 5531.9723401382735, 5539.91971565557, 5543.695096769717, 5550.0, 3893.7274390793505, 4041.696872734498, 4053.067794407244, 4053.2704113258715, 4057.087155390014, 5801.332846722681, 5813.593048486566, 5865.530757539302, 5866.472017518444, 5869.7945571904775, 5582.358028826737, 5614.326280846324, 5627.212190293444, 5639.943600563942, 5643.830685079454, 5597.468240517144, 5641.0, 5656.038473459439, 5656.406077361818, 5664.26364572603, 5397.78408863641, 5510.889782204414, 5515.0, 5517.641353312022, 5521.282233309644, 5661.688607126483, 5666.178404131296, 5667.291588551431, 5672.688002159921, 5673.092305231144, 5333.626646134889, 5454.236406903116, 5519.978803921287, 5608.495235428831, 5612.130119831432], "unit": "score", "name": "prototype.html", "value": 4234.403590994074}, {"lowerIsBetter": false, "replicates": [656.9770058047966, 667.1260648550399, 739.4712780362041, 745.2137994415891, 767.309421520631, 9987.750306242348, 10144.543495542699, 10165.186785057196, 10237.334573252743, 10412.219083568725, 10711.892881071188, 10798.838017429745, 10801.13590912727, 10807.0, 10840.078593319558, 629.3423372575646, 634.7175506899432, 786.6617354537561, 789.3211837819471, 806.4113197365926, 796.2714116583319, 796.5300472721093, 799.6361655446786, 802.9397795165386, 803.5018288661038, 835.3567752830317, 840.0381563110235, 841.0160112668193, 841.5077179849795, 841.8021764885247, 650.5218664281749, 656.8029591122668, 814.4298990706529, 826.1119296755951, 828.7969447485344, 619.6808643548576, 620.1287191495956, 620.3579295429254, 620.5842085802523, 621.142822904389, 10667.413292268922, 10830.296030757976, 10840.566377344896, 10845.457727113691, 10858.457077146111, 10862.891371086267, 11449.0, 11485.0, 11488.827667584992, 11501.30992140466, 8666.653333866638, 8871.556422178865, 8962.103789621051, 8973.730788076367, 8980.8652870207, 3246.5130230465384, 3277.8688852445875, 3280.950785738216, 3286.65490123536, 3291.5062740589105, 35528.28943421143, 36210.456843147374, 36661.45007824885, 36882.07794805124, 36936.0, 7203.747868824566, 7473.065866766654, 7482.326590606872, 7582.431317651198, 7591.164971853203, 16251.618612418077, 16255.51233462998, 16263.268152933146, 16273.267702953395, 16295.755563666316, 6125.908111378333, 6243.157173781572, 6261.592996455216, 6348.0, 6374.362563743589, 3219.291755813764, 3313.7680362374886, 3356.697897189216, 3380.5267262583257, 3431.4338134208074, 2362.893669784864, 2392.7128744550764, 2394.616861302183, 2399.808015358767, 2401.6757737705534, 410.365984553865, 419.40235164889907, 435.7929983257927, 435.8910272431892, 436.27795997623986, 393.74996876983323, 432.71873282366084, 454.5227511113318, 532.9413764485903, 553.7591147850617, 7077.433805295667, 7115.964420177866, 7613.847723045508, 7788.493747906368, 7949.761507154794, 429.0732018839292, 471.64626530102424, 532.624499727691, 574.9741261643236, 594.5303210463685, 3286.14560214346, 3435.7766745161985, 3484.8954531364097, 3494.790312581253, 3586.085548185196, 45710.54289457129, 46402.76798615985, 46453.0, 50481.24278135831, 55450.44549554533, 40124.799376002935, 40230.798846005586, 40237.39643905344, 40276.59723402787, 40664.593354066674, 37279.25441491155, 38230.42654360187, 38429.80785096057, 39283.607163928566, 39470.605293947265, 7290.744823931137, 7392.149902761036, 7566.35685966699, 7681.577513236825, 7843.7254696085365, 30268.0, 30277.0, 30811.537826932166, 30830.0, 30966.22584435407, 34088.0, 37316.626833731316, 37535.0, 37732.0, 37985.24029519339, 9413.52932353366, 9664.275179361717, 10160.136388406772, 10233.13018393415, 10276.332038417479, 10555.208359372924, 10581.206409519471, 10582.259241853304, 10710.625128120479, 10725.463726813472, 9977.700668979942, 10009.749756256151, 10120.848187277345, 10257.076863082359, 10376.118029967538, 9673.177779888789, 9887.456189909624, 9922.801543969224, 10143.34068285559, 10224.182065434896, 9784.755381115529, 9885.159761420073, 9936.850947235653, 10236.078752912274, 10469.0, 8108.635111419882, 8374.162583741578, 8429.452085614415, 8489.74530764078, 8551.10213427606, 7795.610219488889, 8045.436819422584, 8218.21926916942, 8230.753077407688, 8456.661733530836], "unit": "score", "name": "yui.html", "value": 5369.3227053782775}], "name": "dromaeo_css", "value": 6226.389732242822}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 108.0, 113.0, 113.0, 113.0, 105.0, 115.0, 113.0, 104.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 157.0, 163.0, 135.0, 148.0, 157.0, 129.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 164.0, 162.0, 162.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 80.0, 95.0, 71.0, 71.0, 71.0, 105.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 128.0, 94.0, 95.0, 96.0, 131.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 71.0, 71.0, 72.0, 80.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [88.0, 82.0, 84.0, 84.0, 82.0, 83.0, 82.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 119.0, 119.0, 120.0, 126.0, 135.0, 122.0, 127.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [150.0, 137.0, 150.0, 164.0, 148.0, 137.0, 162.0, 137.0, 142.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 73.0, 70.0, 69.0, 69.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1523.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.18004625041294], "unit": "score", "name": "Richards", "value": 213.71830799999998}, {"lowerIsBetter": false, "replicates": [185.9427296392711], "unit": "score", "name": "DeltaBlue", "value": 355.5826040000001}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [11882.35294117647], "unit": "score", "name": "Boyer", "value": 56.08847029702973}, {"lowerIsBetter": false, "replicates": [27405.405405405407], "unit": "score", "name": "RegExp", "value": 33.241070019723885}, {"lowerIsBetter": false, "replicates": [616.0440906307409], "unit": "score", "name": "Splay", "value": 132.28111630218692}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19801.303995948474}]} 18:12:50 INFO - RETURN: dromaeo_css: 6226.39 18:12:50 INFO - RETURN: kraken: 1523.50 18:12:50 INFO - RETURN: v8_7: 19801.30 18:12:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19801.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6226.39"}}} 18:12:50 INFO - Return code: 0 18:12:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:12:50 INFO - # TBPL SUCCESS # 18:12:50 INFO - Running post-action listener: _resource_record_post_action 18:12:50 INFO - Running post-run listener: _resource_record_post_run 18:12:51 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 4096; Write bytes: 563367936; Read time: 12; Write time: 826252 18:12:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226742272; Read time: 0; Write time: 343388 18:12:51 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315822080; Read time: 12; Write time: 457500 18:12:51 INFO - Running post-run listener: _upload_blobber_files 18:12:51 INFO - Blob upload gear active. 18:12:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:12:51 INFO - Copying logs to upload dir... 18:12:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.597084 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-17 18:12:50.993208) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:12:50.996445) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009860 build_url: 'https://queue.taskcluster.net/v1/task/KTJF1JIjRdC93-LnnksKRQ/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-17 18:12:51.048177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:12:51.048498) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450403499.157026-1350334684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:12:51.097804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:12:51.098124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:12:51.098402) ========= ========= Total master_lag: 0.24 =========