builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1447481246.13 results: success (0) buildid: 20151113211931 builduid: 4cb3b8905da04c46bad99c3fc3b8ec0e revision: 81de57cbfed15c61062f2292cef14caf9c21d989 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.133095) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.133517) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.133978) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006591 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.188352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.188700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.302130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.302426) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004317 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.352657) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.353468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.354453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.354786) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 22:07:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.2M=0s 2015-11-13 22:07:26 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.548963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.549274) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.598607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:26.598987) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81de57cbfed15c61062f2292cef14caf9c21d989 --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 81de57cbfed15c61062f2292cef14caf9c21d989 --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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 22:07:26,975 truncating revision to first 12 chars 2015-11-13 22:07:26,975 Setting DEBUG logging. 2015-11-13 22:07:26,975 attempt 1/10 2015-11-13 22:07:26,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81de57cbfed1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 22:07:27,197 unpacking tar archive at: fx-team-81de57cbfed1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:27.114682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:27.115387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:27.133596) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:27.133897) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 22:07:27.134338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-13 22:07:27.134674) ========= /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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:27 INFO - MultiFileLogger online at 20151113 22:07:27 in /builds/slave/test 22:07:27 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 22:07:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:27 INFO - {'append_to_log': False, 22:07:27 INFO - 'base_work_dir': '/builds/slave/test', 22:07:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:07:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:27 INFO - 'branch': 'Fx-Team-Non-PGO', 22:07:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:27 INFO - 'config_files': ('talos/linux_config.py',), 22:07:27 INFO - 'default_actions': ('clobber', 22:07:27 INFO - 'read-buildbot-config', 22:07:27 INFO - 'download-and-extract', 22:07:27 INFO - 'populate-webroot', 22:07:27 INFO - 'create-virtualenv', 22:07:27 INFO - 'install', 22:07:27 INFO - 'run-tests'), 22:07:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:27 INFO - 'download_minidump_stackwalk': True, 22:07:27 INFO - 'download_symbols': 'ondemand', 22:07:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:27 INFO - 'installer_path': 'installer.exe', 22:07:27 INFO - 'log_level': 'info', 22:07:27 INFO - 'log_name': 'talos', 22:07:27 INFO - 'log_to_console': True, 22:07:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:27 INFO - 'opt_config_files': (), 22:07:27 INFO - 'pip_index': False, 22:07:27 INFO - 'sps_profile': False, 22:07:27 INFO - 'sps_profile_interval': 0, 22:07:27 INFO - 'suite': 'dromaeojs', 22:07:27 INFO - 'system_bits': '64', 22:07:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:27 INFO - 'title': 'talos-linux64-ix-008', 22:07:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:27 INFO - 'use_talos_json': True, 22:07:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:27 INFO - 'work_dir': 'build'} 22:07:27 INFO - ##### 22:07:27 INFO - ##### Running clobber step. 22:07:27 INFO - ##### 22:07:27 INFO - Running pre-action listener: _resource_record_pre_action 22:07:27 INFO - Running main action method: clobber 22:07:27 INFO - rmtree: /builds/slave/test/build 22:07:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:28 INFO - Running post-action listener: _resource_record_post_action 22:07:28 INFO - ##### 22:07:28 INFO - ##### Running read-buildbot-config step. 22:07:28 INFO - ##### 22:07:28 INFO - Running pre-action listener: _resource_record_pre_action 22:07:28 INFO - Running main action method: read_buildbot_config 22:07:28 INFO - Using buildbot properties: 22:07:28 INFO - { 22:07:28 INFO - "properties": { 22:07:28 INFO - "buildnumber": 2062, 22:07:28 INFO - "product": "firefox", 22:07:28 INFO - "script_repo_revision": "production", 22:07:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:07:28 INFO - "repository": "", 22:07:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:07:28 INFO - "buildid": "20151113211931", 22:07:28 INFO - "slavename": "talos-linux64-ix-008", 22:07:28 INFO - "pgo_build": "False", 22:07:28 INFO - "basedir": "/builds/slave/test", 22:07:28 INFO - "project": "", 22:07:28 INFO - "platform": "ubuntu64_hw", 22:07:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:28 INFO - "slavebuilddir": "test", 22:07:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:07:28 INFO - "branch": "fx-team", 22:07:28 INFO - "repo_path": "integration/fx-team", 22:07:28 INFO - "stage_platform": "linux64", 22:07:28 INFO - "builduid": "4cb3b8905da04c46bad99c3fc3b8ec0e", 22:07:28 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:07:28 INFO - }, 22:07:28 INFO - "sourcestamp": { 22:07:28 INFO - "repository": "", 22:07:28 INFO - "hasPatch": false, 22:07:28 INFO - "project": "", 22:07:28 INFO - "branch": "fx-team-linux64-talos", 22:07:28 INFO - "changes": [ 22:07:28 INFO - { 22:07:28 INFO - "category": null, 22:07:28 INFO - "files": [ 22:07:28 INFO - { 22:07:28 INFO - "url": null, 22:07:28 INFO - "name": "https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:07:28 INFO - } 22:07:28 INFO - ], 22:07:28 INFO - "repository": "", 22:07:28 INFO - "rev": "81de57cbfed15c61062f2292cef14caf9c21d989", 22:07:28 INFO - "who": "philringnalda@gmail.com", 22:07:28 INFO - "when": 1447481230, 22:07:28 INFO - "number": 6661707, 22:07:28 INFO - "comments": "Merge m-c to f-t", 22:07:28 INFO - "project": "", 22:07:28 INFO - "at": "Fri 13 Nov 2015 22:07:10", 22:07:28 INFO - "branch": "fx-team-linux64-talos", 22:07:28 INFO - "revlink": "", 22:07:28 INFO - "properties": [ 22:07:28 INFO - [ 22:07:28 INFO - "buildid", 22:07:28 INFO - "20151113211931", 22:07:28 INFO - "Change" 22:07:28 INFO - ], 22:07:28 INFO - [ 22:07:28 INFO - "builduid", 22:07:28 INFO - "4cb3b8905da04c46bad99c3fc3b8ec0e", 22:07:28 INFO - "Change" 22:07:28 INFO - ], 22:07:28 INFO - [ 22:07:28 INFO - "pgo_build", 22:07:28 INFO - "False", 22:07:28 INFO - "Change" 22:07:28 INFO - ] 22:07:28 INFO - ], 22:07:28 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:07:28 INFO - } 22:07:28 INFO - ], 22:07:28 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:07:28 INFO - } 22:07:28 INFO - } 22:07:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:07:28 INFO - Running post-action listener: _resource_record_post_action 22:07:28 INFO - ##### 22:07:28 INFO - ##### Running download-and-extract step. 22:07:28 INFO - ##### 22:07:28 INFO - Running pre-action listener: _resource_record_pre_action 22:07:28 INFO - Running main action method: download_and_extract 22:07:28 INFO - mkdir: /builds/slave/test/build/tests 22:07:28 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')]} 22:07:28 INFO - https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/test_packages.json 22:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/test_packages.json 22:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:07:29 INFO - Downloaded 1302 bytes. 22:07:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:07:29 INFO - Using the following test package requirements: 22:07:29 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'jsshell-linux-x86_64.zip'], 22:07:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:07:29 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:07:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:29 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')]} 22:07:29 INFO - https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:33 INFO - Downloaded 21258039 bytes. 22:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:07:34 INFO - Return code: 0 22:07:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:34 INFO - https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:37 INFO - Downloaded 21258039 bytes. 22:07:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:07:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:07:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:07:38 INFO - Return code: 0 22:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:38 INFO - https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:39 INFO - Downloaded 11131693 bytes. 22:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:07:39 INFO - Return code: 0 22:07:39 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')]} 22:07:39 INFO - https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:40 INFO - Downloaded 55599976 bytes. 22:07:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:40 INFO - mkdir: /builds/slave/test/properties 22:07:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:40 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:40 INFO - Contents: 22:07:40 INFO - build_url:https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:40 INFO - Running post-action listener: _resource_record_post_action 22:07:40 INFO - Running post-action listener: set_extra_try_arguments 22:07:40 INFO - ##### 22:07:40 INFO - ##### Running populate-webroot step. 22:07:40 INFO - ##### 22:07:40 INFO - Running pre-action listener: _resource_record_pre_action 22:07:40 INFO - Running main action method: populate_webroot 22:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:07:40 INFO - '../fennec_ids.txt'], 22:07:40 INFO - 'tests': ['tcheck2']}, 22:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:40 INFO - '--tppagecycles', 22:07:40 INFO - '7'], 22:07:40 INFO - 'tests': ['tsvgm']}}, 22:07:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'tests': ['damp', 'tps']}, 22:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['damp', 'tps']}, 22:07:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:40 INFO - 'other': {'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'other_l64': {'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:40 INFO - 'ts_paint', 22:07:40 INFO - 'tpaint', 22:07:40 INFO - 'sessionrestore', 22:07:40 INFO - 'sessionrestore_no_auto_restore']}, 22:07:40 INFO - 'svgr': {'tests': ['tsvgx', 22:07:40 INFO - 'tsvgr_opacity', 22:07:40 INFO - 'tart', 22:07:40 INFO - 'tscrollx', 22:07:40 INFO - 'cart']}, 22:07:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['tsvgx', 22:07:40 INFO - 'tsvgr_opacity', 22:07:40 INFO - 'tart', 22:07:40 INFO - 'tscrollx', 22:07:40 INFO - 'cart']}, 22:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'tests': ['tp5o']}, 22:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'talos_options': ['--e10s'], 22:07:40 INFO - 'tests': ['tp5o']}, 22:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'talos_options': ['--xperf_path', 22:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:40 INFO - 'tests': ['tp5n']}, 22:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:40 INFO - 'talos_options': ['--e10s', 22:07:40 INFO - '--xperf_path', 22:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:40 INFO - 'tests': ['tp5n']}}, 22:07:40 INFO - 'talos.zip': {'path': '', 22:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:40 INFO - Running post-action listener: _resource_record_post_action 22:07:40 INFO - ##### 22:07:40 INFO - ##### Running create-virtualenv step. 22:07:40 INFO - ##### 22:07:40 INFO - Running pre-action listener: _resource_record_pre_action 22:07:40 INFO - Running main action method: create_virtualenv 22:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:40 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 22:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:41 INFO - Using real prefix '/usr' 22:07:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:43 INFO - Installing pip.................done. 22:07:43 INFO - Return code: 0 22:07:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:43 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')]} 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:43 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')]} 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:43 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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:43 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 22:07:43 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 22:07:43 INFO - Using env: {'DISPLAY': ':0', 22:07:43 INFO - 'HOME': '/home/cltbld', 22:07:43 INFO - 'LANG': 'en_US.UTF-8', 22:07:43 INFO - 'LANGUAGE': 'en_US:en', 22:07:43 INFO - 'LOGNAME': 'cltbld', 22:07:43 INFO - 'MAIL': '/var/mail/cltbld', 22:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:43 INFO - 'MOZ_NO_REMOTE': '1', 22:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:43 INFO - 'NO_EM_RESTART': '1', 22:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:43 INFO - 'PWD': '/builds/slave/test', 22:07:43 INFO - 'SHELL': '/bin/bash', 22:07:43 INFO - 'SHLVL': '1', 22:07:43 INFO - 'TERM': 'linux', 22:07:43 INFO - 'TMOUT': '86400', 22:07:43 INFO - 'USER': 'cltbld', 22:07:43 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:43 INFO - '_': '/tools/buildbot/bin/python'} 22:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:43 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 22:07:43 INFO - Cleaning up... 22:07:43 INFO - Return code: 0 22:07:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07:43 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')]} 22:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:43 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')]} 22:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:43 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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:43 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 22:07:43 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 22:07:43 INFO - Using env: {'DISPLAY': ':0', 22:07:43 INFO - 'HOME': '/home/cltbld', 22:07:43 INFO - 'LANG': 'en_US.UTF-8', 22:07:43 INFO - 'LANGUAGE': 'en_US:en', 22:07:43 INFO - 'LOGNAME': 'cltbld', 22:07:43 INFO - 'MAIL': '/var/mail/cltbld', 22:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:43 INFO - 'MOZ_NO_REMOTE': '1', 22:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:43 INFO - 'NO_EM_RESTART': '1', 22:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:43 INFO - 'PWD': '/builds/slave/test', 22:07:43 INFO - 'SHELL': '/bin/bash', 22:07:43 INFO - 'SHLVL': '1', 22:07:43 INFO - 'TERM': 'linux', 22:07:43 INFO - 'TMOUT': '86400', 22:07:43 INFO - 'USER': 'cltbld', 22:07:43 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:43 INFO - '_': '/tools/buildbot/bin/python'} 22:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:43 INFO - Downloading/unpacking psutil>=0.7.1 22:07:43 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 22:07:43 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 22:07:43 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 22:07:43 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 22:07:43 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 22:07:43 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 22:07:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:07:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:45 INFO - Installing collected packages: psutil 22:07:45 INFO - Running setup.py install for psutil 22:07:45 INFO - building 'psutil._psutil_linux' extension 22:07:45 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 22:07:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:07:45 INFO - building 'psutil._psutil_posix' extension 22:07:45 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 22:07:46 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 22:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:46 INFO - Successfully installed psutil 22:07:46 INFO - Cleaning up... 22:07:46 INFO - Return code: 0 22:07:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:46 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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:46 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 22:07:46 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 22:07:46 INFO - Using env: {'DISPLAY': ':0', 22:07:46 INFO - 'HOME': '/home/cltbld', 22:07:46 INFO - 'LANG': 'en_US.UTF-8', 22:07:46 INFO - 'LANGUAGE': 'en_US:en', 22:07:46 INFO - 'LOGNAME': 'cltbld', 22:07:46 INFO - 'MAIL': '/var/mail/cltbld', 22:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:46 INFO - 'MOZ_NO_REMOTE': '1', 22:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:46 INFO - 'NO_EM_RESTART': '1', 22:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:46 INFO - 'PWD': '/builds/slave/test', 22:07:46 INFO - 'SHELL': '/bin/bash', 22:07:46 INFO - 'SHLVL': '1', 22:07:46 INFO - 'TERM': 'linux', 22:07:46 INFO - 'TMOUT': '86400', 22:07:46 INFO - 'USER': 'cltbld', 22:07:46 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:46 INFO - '_': '/tools/buildbot/bin/python'} 22:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:46 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 22:07:46 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 22:07:46 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 22:07:46 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 22:07:46 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 22:07:46 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 22:07:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:48 INFO - Installing collected packages: mozsystemmonitor 22:07:48 INFO - Running setup.py install for mozsystemmonitor 22:07:48 INFO - Successfully installed mozsystemmonitor 22:07:48 INFO - Cleaning up... 22:07:48 INFO - Return code: 0 22:07:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:07:48 INFO - Using env: {'DISPLAY': ':0', 22:07:48 INFO - 'HOME': '/home/cltbld', 22:07:48 INFO - 'LANG': 'en_US.UTF-8', 22:07:48 INFO - 'LANGUAGE': 'en_US:en', 22:07:48 INFO - 'LOGNAME': 'cltbld', 22:07:48 INFO - 'MAIL': '/var/mail/cltbld', 22:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:48 INFO - 'MOZ_NO_REMOTE': '1', 22:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:48 INFO - 'NO_EM_RESTART': '1', 22:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:48 INFO - 'PWD': '/builds/slave/test', 22:07:48 INFO - 'SHELL': '/bin/bash', 22:07:48 INFO - 'SHLVL': '1', 22:07:48 INFO - 'TERM': 'linux', 22:07:48 INFO - 'TMOUT': '86400', 22:07:48 INFO - 'USER': 'cltbld', 22:07:48 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:48 INFO - '_': '/tools/buildbot/bin/python'} 22:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 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 22:07:50 INFO - Downloading docopt-0.6.1.tar.gz 22:07:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:50 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:50 INFO - Running setup.py install for blobuploader 22:07:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:50 INFO - Running setup.py install for requests 22:07:51 INFO - Running setup.py install for docopt 22:07:51 INFO - Successfully installed blobuploader requests docopt 22:07:51 INFO - Cleaning up... 22:07:51 INFO - Return code: 0 22:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:51 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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:51 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 22:07:51 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 22:07:51 INFO - Using env: {'DISPLAY': ':0', 22:07:51 INFO - 'HOME': '/home/cltbld', 22:07:51 INFO - 'LANG': 'en_US.UTF-8', 22:07:51 INFO - 'LANGUAGE': 'en_US:en', 22:07:51 INFO - 'LOGNAME': 'cltbld', 22:07:51 INFO - 'MAIL': '/var/mail/cltbld', 22:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:51 INFO - 'MOZ_NO_REMOTE': '1', 22:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:51 INFO - 'NO_EM_RESTART': '1', 22:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:51 INFO - 'PWD': '/builds/slave/test', 22:07:51 INFO - 'SHELL': '/bin/bash', 22:07:51 INFO - 'SHLVL': '1', 22:07:51 INFO - 'TERM': 'linux', 22:07:51 INFO - 'TMOUT': '86400', 22:07:51 INFO - 'USER': 'cltbld', 22:07:51 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:51 INFO - '_': '/tools/buildbot/bin/python'} 22:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:51 INFO - Running setup.py (path:/tmp/pip-2zqyWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:51 INFO - Running setup.py (path:/tmp/pip-4H4oD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:51 INFO - Running setup.py (path:/tmp/pip-rYDrRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:51 INFO - Running setup.py (path:/tmp/pip-wFnNgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:51 INFO - Running setup.py (path:/tmp/pip-uo2JpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:52 INFO - Running setup.py (path:/tmp/pip-NTGwWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:52 INFO - Running setup.py (path:/tmp/pip-ybhGRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:52 INFO - Running setup.py (path:/tmp/pip-EZpwn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:52 INFO - Running setup.py (path:/tmp/pip-O5Xe3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:52 INFO - Running setup.py (path:/tmp/pip-k_Of97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:52 INFO - Running setup.py (path:/tmp/pip-LkQctZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:52 INFO - Running setup.py (path:/tmp/pip-xGJTrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:52 INFO - Running setup.py (path:/tmp/pip-svK_vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:52 INFO - Running setup.py (path:/tmp/pip-lk0flI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:52 INFO - Running setup.py (path:/tmp/pip-09rSmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:52 INFO - Running setup.py (path:/tmp/pip-9xvIOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:52 INFO - Running setup.py (path:/tmp/pip-9W3nRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:52 INFO - Running setup.py install for manifestparser 22:07:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:52 INFO - Running setup.py install for mozcrash 22:07:53 INFO - Running setup.py install for mozdebug 22:07:53 INFO - Running setup.py install for mozdevice 22:07:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Running setup.py install for mozfile 22:07:53 INFO - Running setup.py install for mozhttpd 22:07:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Running setup.py install for mozinfo 22:07:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Running setup.py install for mozInstall 22:07:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Running setup.py install for mozleak 22:07:53 INFO - Running setup.py install for mozlog 22:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:53 INFO - Running setup.py install for moznetwork 22:07:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Running setup.py install for mozprocess 22:07:54 INFO - Running setup.py install for mozprofile 22:07:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Running setup.py install for mozrunner 22:07:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Running setup.py install for mozscreenshot 22:07:54 INFO - Running setup.py install for moztest 22:07:54 INFO - Running setup.py install for mozversion 22:07:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:54 INFO - Cleaning up... 22:07:54 INFO - Return code: 0 22:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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', '-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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:54 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 22:07:54 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 22:07:54 INFO - Using env: {'DISPLAY': ':0', 22:07:54 INFO - 'HOME': '/home/cltbld', 22:07:54 INFO - 'LANG': 'en_US.UTF-8', 22:07:54 INFO - 'LANGUAGE': 'en_US:en', 22:07:54 INFO - 'LOGNAME': 'cltbld', 22:07:54 INFO - 'MAIL': '/var/mail/cltbld', 22:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:54 INFO - 'MOZ_NO_REMOTE': '1', 22:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:54 INFO - 'NO_EM_RESTART': '1', 22:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:54 INFO - 'PWD': '/builds/slave/test', 22:07:54 INFO - 'SHELL': '/bin/bash', 22:07:54 INFO - 'SHLVL': '1', 22:07:54 INFO - 'TERM': 'linux', 22:07:54 INFO - 'TMOUT': '86400', 22:07:54 INFO - 'USER': 'cltbld', 22:07:54 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:54 INFO - '_': '/tools/buildbot/bin/python'} 22:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:54 INFO - Running setup.py (path:/tmp/pip-xSRB4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:54 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)) 22:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:54 INFO - Running setup.py (path:/tmp/pip-Ea3Fvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:55 INFO - Running setup.py (path:/tmp/pip-zwgCAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:55 INFO - Running setup.py (path:/tmp/pip-ZXazKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:55 INFO - Running setup.py (path:/tmp/pip-1kVJtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:55 INFO - Running setup.py (path:/tmp/pip-N1zs7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:55 INFO - Running setup.py (path:/tmp/pip-lQJ4nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:55 INFO - Running setup.py (path:/tmp/pip-1EdblC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:55 INFO - Running setup.py (path:/tmp/pip-5W5Bkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:55 INFO - Running setup.py (path:/tmp/pip-BSH1u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:55 INFO - Running setup.py (path:/tmp/pip-s4F9RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:55 INFO - Running setup.py (path:/tmp/pip-8xQEAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:55 INFO - Running setup.py (path:/tmp/pip-6wZb9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:55 INFO - Running setup.py (path:/tmp/pip-inmZU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:55 INFO - Running setup.py (path:/tmp/pip-6E59zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:55 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)) 22:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:55 INFO - Running setup.py (path:/tmp/pip-OsGxZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:56 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)) 22:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:56 INFO - Running setup.py (path:/tmp/pip-eNWOjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:56 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)) 22:07:56 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)) 22:07:56 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)) 22:07:56 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)) 22:07:56 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)) 22:07:56 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)) 22:07:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:57 INFO - Downloading blessings-1.5.1.tar.gz 22:07:57 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 22:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:57 INFO - Installing collected packages: blessings 22:07:57 INFO - Running setup.py install for blessings 22:07:57 INFO - Successfully installed blessings 22:07:57 INFO - Cleaning up... 22:07:58 INFO - Return code: 0 22:07:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:58 INFO - Reading from file tmpfile_stdout 22:07:58 INFO - Current package versions: 22:07:58 INFO - argparse == 1.2.1 22:07:58 INFO - blessings == 1.5.1 22:07:58 INFO - blobuploader == 1.2.4 22:07:58 INFO - docopt == 0.6.1 22:07:58 INFO - manifestparser == 1.1 22:07:58 INFO - mozInstall == 1.12 22:07:58 INFO - mozcrash == 0.16 22:07:58 INFO - mozdebug == 0.1 22:07:58 INFO - mozdevice == 0.47 22:07:58 INFO - mozfile == 1.2 22:07:58 INFO - mozhttpd == 0.7 22:07:58 INFO - mozinfo == 0.9 22:07:58 INFO - mozleak == 0.1 22:07:58 INFO - mozlog == 3.0 22:07:58 INFO - moznetwork == 0.27 22:07:58 INFO - mozprocess == 0.22 22:07:58 INFO - mozprofile == 0.27 22:07:58 INFO - mozrunner == 6.11 22:07:58 INFO - mozscreenshot == 0.1 22:07:58 INFO - mozsystemmonitor == 0.0 22:07:58 INFO - moztest == 0.7 22:07:58 INFO - mozversion == 1.4 22:07:58 INFO - psutil == 3.1.1 22:07:58 INFO - requests == 1.2.3 22:07:58 INFO - wsgiref == 0.1.2 22:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fccc6961c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf306c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, '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': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', '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 22:07:58 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 22:07:58 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 22:07:58 INFO - Using env: {'DISPLAY': ':0', 22:07:58 INFO - 'HOME': '/home/cltbld', 22:07:58 INFO - 'LANG': 'en_US.UTF-8', 22:07:58 INFO - 'LANGUAGE': 'en_US:en', 22:07:58 INFO - 'LOGNAME': 'cltbld', 22:07:58 INFO - 'MAIL': '/var/mail/cltbld', 22:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:58 INFO - 'MOZ_NO_REMOTE': '1', 22:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:58 INFO - 'NO_EM_RESTART': '1', 22:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:58 INFO - 'PWD': '/builds/slave/test', 22:07:58 INFO - 'SHELL': '/bin/bash', 22:07:58 INFO - 'SHLVL': '1', 22:07:58 INFO - 'TERM': 'linux', 22:07:58 INFO - 'TMOUT': '86400', 22:07:58 INFO - 'USER': 'cltbld', 22:07:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:58 INFO - '_': '/tools/buildbot/bin/python'} 22:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 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)) 22:07:58 INFO - Cleaning up... 22:07:58 INFO - Return code: 0 22:07:58 INFO - Running post-action listener: _resource_record_post_action 22:07:58 INFO - Running post-action listener: _start_resource_monitoring 22:07:58 INFO - Starting resource monitoring. 22:07:58 INFO - ##### 22:07:58 INFO - ##### Running install step. 22:07:58 INFO - ##### 22:07:58 INFO - Running pre-action listener: _resource_record_pre_action 22:07:58 INFO - Running main action method: install 22:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:58 INFO - Reading from file tmpfile_stdout 22:07:58 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:58 INFO - Reading from file tmpfile_stdout 22:07:58 INFO - Output received: 22:07:58 INFO - Usage: mozinstall [options] installer 22:07:58 INFO - Options: 22:07:58 INFO - -h, --help show this help message and exit 22:07:58 INFO - -d DEST, --destination=DEST 22:07:58 INFO - Directory to install application into. [default: 22:07:58 INFO - "/builds/slave/test"] 22:07:58 INFO - --app=APP Application being installed. [default: firefox] 22:07:58 INFO - mkdir: /builds/slave/test/build/application 22:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:08:12 INFO - Reading from file tmpfile_stdout 22:08:12 INFO - Output received: 22:08:12 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:12 INFO - Running post-action listener: _resource_record_post_action 22:08:12 INFO - ##### 22:08:12 INFO - ##### Running run-tests step. 22:08:12 INFO - ##### 22:08:12 INFO - Running pre-action listener: _resource_record_pre_action 22:08:12 INFO - Running main action method: run_tests 22:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:12 INFO - Python 2.7.3 22:08:12 INFO - Return code: 0 22:08:12 INFO - grabbing minidump binary from tooltool 22:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070ac0>, '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 0x10719a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:08:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:12 INFO - Return code: 0 22:08:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:12 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/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 22:08:12 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/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 22:08:12 INFO - Using env: {'DISPLAY': ':0', 22:08:12 INFO - 'HOME': '/home/cltbld', 22:08:12 INFO - 'LANG': 'en_US.UTF-8', 22:08:12 INFO - 'LANGUAGE': 'en_US:en', 22:08:12 INFO - 'LOGNAME': 'cltbld', 22:08:12 INFO - 'MAIL': '/var/mail/cltbld', 22:08:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:12 INFO - 'MOZ_NO_REMOTE': '1', 22:08:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:12 INFO - 'NO_EM_RESTART': '1', 22:08:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:12 INFO - 'PWD': '/builds/slave/test', 22:08:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:12 INFO - 'SHELL': '/bin/bash', 22:08:12 INFO - 'SHLVL': '1', 22:08:12 INFO - 'TERM': 'linux', 22:08:12 INFO - 'TMOUT': '86400', 22:08:12 INFO - 'USER': 'cltbld', 22:08:12 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957', 22:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:12 INFO - '_': '/tools/buildbot/bin/python'} 22:08:12 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/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 22:08:13 INFO - mozversion INFO | application_buildid: 20151113211931 22:08:13 INFO - mozversion INFO | application_changeset: 81de57cbfed15c61062f2292cef14caf9c21d989 22:08:13 INFO - mozversion INFO | application_display_name: Nightly 22:08:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:13 INFO - mozversion INFO | application_name: Firefox 22:08:13 INFO - mozversion INFO | application_remotingname: firefox 22:08:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:08:13 INFO - mozversion INFO | application_vendor: Mozilla 22:08:13 INFO - mozversion INFO | application_version: 45.0a1 22:08:13 INFO - mozversion INFO | platform_buildid: 20151113211931 22:08:13 INFO - mozversion INFO | platform_changeset: 81de57cbfed15c61062f2292cef14caf9c21d989 22:08:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:08:13 INFO - mozversion INFO | platform_version: 45.0a1 22:08:13 INFO - 2015-11-13 22:08:13,045 DEBUG : using testdate: 1447481293 22:08:13 INFO - 2015-11-13 22:08:13,045 DEBUG : actual date: 1447481293 22:08:13 INFO - 2015-11-13 22:08:13,091 INFO : starting webserver on 'localhost:59334' 22:08:13 INFO - 2015-11-13 22:08:13,091 INFO : Starting test suite talos-linux64-ix-008 22:08:13 INFO - 2015-11-13 22:08:13,092 INFO : Starting test dromaeo_css 22:08:13 INFO - 2015-11-13 22:08:13,092 DEBUG : operating with platform_type : linux_ 22:08:13 INFO - 2015-11-13 22:08:13,092 INFO : Initialising browser for dromaeo_css test... 22:08:13 INFO - 2015-11-13 22:08:13,099 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5iyZ3/profile http://localhost:59334/getInfo.html 22:08:18 INFO - 2015-11-13 22:08:18,499 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:08:18 INFO - 2015-11-13 22:08:18,499 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:08:18 INFO - 2015-11-13 22:08:18,499 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:08:18 INFO - 2015-11-13 22:08:18,500 DEBUG : BROWSER_OUTPUT: __metrics 22:08:18 INFO - 2015-11-13 22:08:18,616 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:19 INFO - 2015-11-13 22:08:19,768 INFO : Browser initialized. 22:08:19 INFO - 2015-11-13 22:08:19,769 INFO : Running cycle 1/1 for dromaeo_css test... 22:08:19 INFO - 2015-11-13 22:08:19,769 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5iyZ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:08:31 INFO - 2015-11-13 22:08:31,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 140828672 22:08:31 INFO - 2015-11-13 22:08:31,620 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,803 DEBUG : BROWSER_OUTPUT: 1447481362798 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] 22:11:34 INFO - 2015-11-13 22:11:34,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59334/tests/dromaeo/cssquery-ext.html) 22:11:35 INFO - 2015-11-13 22:11:35,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 249364480 22:11:35 INFO - 2015-11-13 22:11:35,818 DEBUG : BROWSER_OUTPUT: 22:14:38 INFO - 2015-11-13 22:14:38,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-ext.html (next: http://localhost:59334/tests/dromaeo/cssquery-jquery.html) 22:14:38 INFO - 2015-11-13 22:14:38,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 225910784 22:14:38 INFO - 2015-11-13 22:14:38,920 DEBUG : BROWSER_OUTPUT: 22:17:40 INFO - 2015-11-13 22:17:40,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59334/tests/dromaeo/cssquery-mootools.html) 22:17:41 INFO - 2015-11-13 22:17:41,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 218083328 22:17:41 INFO - 2015-11-13 22:17:41,533 DEBUG : BROWSER_OUTPUT: 22:20:43 INFO - 2015-11-13 22:20:43,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59334/tests/dromaeo/cssquery-prototype.html) 22:20:44 INFO - 2015-11-13 22:20:44,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 203005952 22:20:44 INFO - 2015-11-13 22:20:44,090 DEBUG : BROWSER_OUTPUT: 22:23:46 INFO - 2015-11-13 22:23:46,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59334/tests/dromaeo/cssquery-yui.html) 22:23:47 INFO - 2015-11-13 22:23:47,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 206884864 22:23:47 INFO - 2015-11-13 22:23:47,372 DEBUG : BROWSER_OUTPUT: 22:26:49 INFO - 2015-11-13 22:26:49,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/dromaeo/cssquery-yui.html (next: http://localhost:59334/tests/dromaeo/cssquery-dojo.html) 22:26:50 INFO - 2015-11-13 22:26:50,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 221069312 22:26:50 INFO - 2015-11-13 22:26:50,012 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,012 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:26:50 INFO - 2015-11-13 22:26:50,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:26:50 INFO - 2015-11-13 22:26:50,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:26:50 INFO - 2015-11-13 22:26:50,012 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:26:50 INFO - 2015-11-13 22:26:50,013 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2653.7346265373467;2751.174647605718;2764.6129541864157;2764.889404423823;2769.293830073332;4611.239145540982;4735;4837.3711417515715;4852.053849499349;4856.2958371036175;4737.289406589005;4812.759362031902;4817.518248175181;4819.662623616348;4823.734694591796;4372.519022907478;4427.180971520263;4435.534268901751;4540.79566419512;4544.568266014723;4288.16380805743;4480.507144214133;4484.955150448486;4521.434820647419;4573.3368661544055;4394.4946331172005;4396.076823866976;4483.618892394151;4495.348174514677;4516.322551617251;4426.645868330525;4433.955660443419;4450.043240703232;4454.821807127711;4473.552644735533;4389.934150987738;4401.669874759374;4417.403650507173;4443.533428989974;4458.8885277867985;4492.146492166478;4605.078984203173;4635.791389387486;4645.465771436295;4727.692699974525;5083.11045567028;5089.821856235014;5103.8468845934685;5106.106431374495;5143.305653736735;5216.061109000379;5217.34783152106;5225.608079394061;5267.762950667229;5269.710165940872;4585.954140458586;4654.976725116353;4663.090697314059;4665.346851440801;4779.713217206979;5334.866628334323;5356.7857285708915;5366.436524164985;5368.302120724359;5410.864728381822;5125.538701516882;5130.820421285237;5135.050015747099;5135.717535535581;5175.378954525406;4970.453250142481;5078.238264260317;5082.415522214993;5083.313752643419;5211.478852114758;5135.152699804565;5135.948640513547;5142.51146141116;5142.794288228504;5153.845384638467;5092.719900405439;5099.413567439718;5103.897922041539;5105.642605017687;5132.692038477703;4122.835086596562;4208.621224089847;4210.157968406331;4284.764337961442;4309.353596960418;3755.2677227940835;3771.773693578339;3774.5470543534952;3797.430385442206;3804.752691075071;4492.932606010912;4493.415855938707;4500.437445319335;4505.414296141546;4529.637628989739;5012.523810238022;5127.974360128175;5184.196449550326;5186.766595503212;5288.9735551322765;4494.910101797946;4499.482559505634;4509.571590698878;4513.255312873404;4543.1822271990695;4599.885002874955;4614.238650622677;4614.307853821953;4622.422197225347;4649.070185962821;4701.835435759732;4773.928391074067;4809.5430934061205;4815.085133824702;4849.927251091307;5175.767090480862;5241.659292145999;5242.449542798104;5246.580273578181;5246.658967167122;4963.354763880817;4968.726720030433;4969.055879382906;4969.428515720739;4995.700257984533;4915.926261106015;5046.142155833591;5050.242463630485;5058;5196.4283928767045;5192.402873669576;5194.948050519446;5196.948030519798;5197.194434862602;5204.739763011758;5026.095302845377;5027.01973115239;5027.472115427974;5027.949720502895;5073.137566613758;4791.329213910125;4891.31521586971;4908.6073114151495;4910.337104490848;5014.398272207359;4957.7273249971595;4965.900681986413;4977.104121258209;4977.4773648767805;5006.299118123538;5083.491650834887;5093.312402825572;5093.71984540839;5098.1588037973315;5133.435322114639;4752.52474752522;4834.540718631724;4875.829345972874;4878.438979517259;4946.851594452172 22:26:50 INFO - 2015-11-13 22:26:50,013 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.3566334378809;570.3241658634518;583.594401890686;588.7527238559804;590.5452801342964;26333.078342258024;26925.326866828338;37640.62359376402;37942;37999.24001519968;40378.394324085166;40889;40981;41039;41066.79466602663;7024.157101147869;7912.327452166558;8136.471129376601;8186.672533098669;8187.0994190638985;6782.321767823203;10168.288219824615;10437.165026797838;10446.320989135682;10453.163746900267;10265.230107741912;10367.89632103677;10374.533146008447;10387.324823886462;10391.740206494822;7244.203137654854;7415.5179913306;10208.132308753764;10326.638567650096;10349.068583827417;10101.141402980755;10253.84619230712;10261.538230779634;10263.281570290008;10264.89735102647;37925.43111853324;38379;38398.424023639665;38469.80765096185;38579.614203857884;2786.6656001279975;2830.8584570771586;2869.5982562441277;3040.467918114321;3436.3127374525193;27378.589321160198;27692.72307276942;28236.717632823613;29290.56064159018;30260.54609180864;2883.870225839821;2955.3645966117174;3007.5639032340405;3145.889893853704;3255.739540836751;217369;218911;218925;221022.9999999984;221187;48665;49752;58283.41716582865;58465.70767146137;58477.12284315738;67480;68453.65773171102;68536;68553.31446685469;68583.65708171527;13687.589372318846;13753.656158596115;13773.03588748778;13885.305734713224;13905.652358691113;9742.46416447088;9762.609495620096;9763.414195148314;9779;9785;19047.52381190481;19408.80591194098;19537.80462195388;19560.21759129619;19641;7759.844803103906;8000.119986801447;8085.514869107872;8103.270705636521;8180.263776260165;772.9806754831175;783.9372850171973;819.2135549872071;852.8123812761182;887.0995939121797;26412.867935660197;26639.600405993537;26647.200583982125;26679.33301667474;26691.46617067648;881.0704706534667;927.1284992107397;948.7580666929889;1023.5496381592076;1051.9322887269427;13691.973102017388;13816.723665526633;13910.652233694238;14115.71768564623;14173.22047287409;337137;344756;344774;344938;346367;48078;48517.75741121272;48609.270860936405;48658.75670621624;48668.756656216494;1152.2683096233952;1157.5427706056062;1164.4236103129006;1166.8016437205695;1167.0255336793873;25194.62208066917;25778.355541110872;26241.343966400993;26263.21210363692;26291.21126366212;36476.63523364838;37363.81318093501;42506.14987700291;43234.56765432305;43261.567384325754;214327;215381;215649;215868;215908;24752.133675321278;24986.750132499168;29017.274568135967;29405.264868377606;29412;37725.62274377221;38429.6157038426;38935;39727.404088938114;39805.40291895682;32167.356652866343;32520;32938.341233175684;33315.66684333126;33501;32656.510152348208;32803.17992050122;32805.83597082095;32882.671173288916;33043.504347434326;32488.51267230946;32689.509657355633;32985.34029319448;33428.33143337071;33472.824266422605;28593.14220573386;29431;30006.649700763082;30231.395372092877;30446.391072178874;25154;25724;25866.224013279632;25891.741082588935;26185.869070654524 22:26:50 INFO - 2015-11-13 22:26:50,014 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.3849048505507;333.93308379726767;345.72687576814303;346.64122633074743;347.6992401572639;12533.811992820116;12968.74062518749;15174.696506069871;15176.468823591176;16146.757798633014;14626.341814618341;15248.466303679374;15519.146446945413;15727.921360393182;15731.449399271029;4971.850844474671;4973.079980203655;5080.517350851663;5080.517350851663;5088.567471764904;3573.213892943548;3681.7975011374365;5127.230915362707;5670.858228544278;5913.408659134096;5806.767729290823;5819.272590926134;5833.183354330397;5851.970740146315;5864.091065884794;5722.484976352128;5918.7928422505;5933.288005439354;5934.8813023739285;5941;5147.716875571842;5168.405633352138;5169.819056333048;5200.869978250574;5204.193350030751;18519.72220416695;19111;19135.904320478447;19314.32399865998;19870.3045393412;1694.1190580897864;1793.8923664580168;1809.1677828199045;1825.12394050855;1872.803355647651;12256.325902075383;12375.566855160116;12414.565490207799;12513.499460021589;13479.932600337033;1791.408835084419;1876.774787025552;1925.6052509235574;1932.0726051495221;1972.2702600037935;60490.69754651243;62335;62394.37605623931;62750.37249627491;62848.68575657092;15177.089374637337;15376.15431151275;15391.846081539265;15407.152606606744;15421.460248891459;22555.774442255697;22732.20437284687;22854.42863928382;22860.542789144125;22898;7926.048874135141;7963.960180199062;7983.441159118806;8068.636911339004;8381.07808141104;6927.618980955995;6957.860842783217;6993.755218567428;7011.368976792011;7019.789406317716;7343.926560734431;7464.85070298591;7496.925030749731;7498.812529686692;7511.06111736033;998.5756053677159;1006.1146191351564;1007.6825799873163;2025.2810252360493;2895.7837708162624;387.5814120749584;393.02137677183606;402.5994135834863;414.7822393243511;421.6394982290159;9189.63241470347;9896.059874312074;10003.099721025143;10254.487275636338;10271.794564108675;403.87681757064377;412.8162967479503;416.8811888611731;420.93896385024;425.69775459424153;5382.623216374895;5575.553955683536;5621.831345059655;5722.284714410699;5744.770209191669;335053;337619;338311;497978;546001;60169.699151504836;62954.68522657357;73644;74849;75222;427.1734194333912;438.58991842627245;439.4353256066004;441.3357896365949;442.44252242174446;9117.179453849185;9247.76880577991;9355.017723138972;9410.153086222273;9452.669156579486;31797.20506987344;32377.35245295128;32515.674843251265;32807;33325.66674333226;42903.35644965265;43027.35458968055;43453.78273108614;43915.78042109769;44282;7490.887636685345;7491.962540187482;7690.577018263825;7695.88456173169;7728.574928378993;10842.728931776768;10940.234183607072;11030.779384412428;11055.22613417053;11134.888651113386;9848.803023939625;9963.25275604318;10111.090001899864;10153.796924061626;10159.84760228612;7806.804829879298;9834.60661573529;9884.802303953737;9942.15491683215;10165.18678505703;8121.187881211831;8507.617157227816;9415.435073895589;9574.617015319309;9586.328956972944;7253.963730181315;7301.598412087386;7408.444366672629;7419.629018549159;7424.591647459441;9340.879094508702;9415.858762118436;9627.229821614394;9651.565679544297;9652.324337296603 22:26:50 INFO - 2015-11-13 22:26:50,018 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1269.5746924780199;1642.6632540329233;1683.4949515145454;1708.2142214581293;1730.5760088778252;6426.614403135809;6997.230304666489;7124.394426473756;7137.964310178449;7147.892781608267;7285.41716662667;7398.149212840525;7402.555846649205;7402.629868506567;7408.925910740891;1791.4804706635125;1852.0832188066927;2089.83281337493;2096.811286984171;2097.6958341040618;2115.249086574267;2126.9680954785613;2129.957400851982;2131.126238242321;2131.6589345704692;2032.583320419318;2062.83497320214;2075.688646702999;2076.6262072826885;2078.4699901525164;1773.5477453249403;1803.9188236529387;2014.355406269994;2056.6709326507835;2056.8868712220824;2051;2056.1364227024687;2080.1055546115163;2080.5110798962232;2081.7814129516487;7287.161976372679;7287.9271207287775;7288.8177795555;7314.305141011649;7334.963325183393;4352.086061926999;4442.666799990014;4442.93335599963;4446.133004064209;4449;2837.957430638542;2885.6825749167574;2888.42231553688;2925.6928022557536;2951.6900725423734;924.3113880159324;932.0958670090001;934.0845970948441;968.1093394077466;977.7164622259608;9799;9827.852582211273;9841.114299712988;9890.20878329739;9915.504224788803;4051.108756073659;4058.5332686741403;4150.937735933963;4192.350185721218;4222.218889505451;8144.389170812213;8164.428490005761;8175.14161013097;8187.83624327522;8188.549629770419;4373.081652852873;4392.978035109804;4395;4399.450068741407;4400.119976004812;3962.742421742635;3966.424868394067;3971.3645816669773;3989.1423343981182;3989.880303590839;3468.2890007548895;3518.296340731864;3521.1373213562842;3522.2075033117344;3544.043108360728;1060.596973150198;1062.5165549675035;1064.5475672839168;1074.4198133008088;1078.7249251440833;836.8117173636005;843.9831203375898;952.9285303602257;1154.5958914380067;1155.2433156282648;5778.624389414675;6789.93210067893;6873.037774711544;6945.444364450933;6946.16646002483;579.1486514823204;585.689584520205;590.8050343386672;593.6764463367475;601.0233370772495;5325.147976323769;5340.572754179656;5357.383900851374;5361;5375.381831089397;8620.78448038804;8995.730128096167;9031.63873445068;9036.27709783229;9052.8642070369;8845.071267516947;8848.380613357003;8864;8894.510801905957;8906.421082629608;6771.424428923498;6795.320467953264;6959.164900211906;7037.472189585802;7042.049323341385;6644.767433139817;6654.933450665431;6666.300038495888;6686.7993960181275;6686.83282917931;7806.765797026098;7956.721514746956;7969.3226075784205;7978.601069946596;7988.161243069627;8064.233897779702;8253.587320634064;8316.334693224648;8419.873701894354;8472.66109355619;6555.4427873631275;6567.146270984741;6603.900941485786;6618.146918862726;6637.838378283877;7108.537945033556;7166.964165179141;7174.461915356264;7175;7191.568505889663;6533.314002029909;6541.6402097885075;6677.69950352245;6723.966380168068;6919.100516932766;6636.1373021508825;6723.327667233433;6748.460123190035;6795.830104247236;6833.965830170818;5545.500904918576;5685.71571421419;6618.2719900811835;6726.529142959946;6738.427233684995;6007.90988135187;6075.483583895419;6081.966065768742;6106.57253992234;6123.969380153071;6157.907631385443;6181.505479561714;6193.411625895533;6242.313345531897;6242.375762423903 22:26:50 INFO - 2015-11-13 22:26:50,019 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.98366589837576;301.51456155589494;302.4374663126585;306.8067117715839;310.3807903233049;5350.5184533391985;5400.243965844785;5443.265159203511;5468.9726551367285;5522.420145884685;5268.868278293045;5427.213054107152;5434.945650543494;5446.346438427385;5458.9454105458935;4133.937990930139;4191.622753952143;4195.307774217258;4203.033302340464;4207.894802629929;3963.7225394222414;4027.7784721840285;4051.4733084698946;4165.33354663254;4185.937210941838;4117.649999750025;4147.523034851;4149;4153.7507749535125;4171.72883762556;4154.356074808409;4155.293600087977;4156.667466602679;4160.251154792136;4163.812628431728;3627.2745450909924;3647.379945409287;3650.3976843820737;3657.5976642569294;3659.7804131751914;5125.359330083739;5251.396089449724;5253.159494480865;5254.3169387979315;5256.553192978601;4821.0357928414105;4829.637777166727;4833.347498087784;4834.492378300298;4835.492273311287;5707.0583353747;5710.457506536873;5712.257406537124;5713.457221563945;5719.857003574903;3776.093737503007;3866.7679939203736;3882.650561449483;4001.4397984282223;4016.8393264269394;5989.31122920861;5997.790077347272;6004.039353703431;6005.549583781234;6011.57918945674;4090.181963607231;4119.176164767058;4119.382092686061;4121.62905338521;4127.09203975125;4184.937225941613;4189.329707246887;4192.434021407132;4194.748315101104;4196.971741923187;4633.49031606523;4766.856994290177;4771.856844294677;4777.116233496814;4794.472608013116;5690.487856092972;5691.373948865621;5701.600887937804;5702.344230413472;5706.8871570044275;1470.6102882736084;1484.6288427893028;1486.5317425011303;1490.3368001239562;1490.4559835659907;1004.347174336687;1007.4257673126394;1009.8737657792776;1013.0780989299849;1028.3264461777549;5035.974820125876;5037.420696619935;5039.143345631252;5048.192289233705;5051.848444546669;5924.496417804448;5997.070454079625;5998.25021872266;5998.25021872266;6004.369541198199;5049.82325618609;5052.747362631927;5053.84838454847;5054.039732450822;5055.292259083732;3122.141411111917;3177.539256807796;3207.294395233045;3209.791363561361;3217.8391080445886;5595.63628364155;5604.579656525777;5605;5610.018246806792;5610.354809196913;6087.786927457518;6090.299615544269;6092.268927728701;6094.481969032593;6096.69516524172;5482.479164479368;5588.329400471969;5601.075822489243;5601.327840659147;5606.327240731057;5912.201852749824;5914.911276330772;5915.319738229987;5915.526757859447;5920.200772895776;5589.916151257816;5685.459881311269;5744.712764361849;5759.740811663569;5776.075827867521;5621.690807005654;5643.887122257614;5647.463490968352;5649.858753531194;5658.377578466448;4087.9182416350914;4090.959090409058;4115.279826030493;4118.361653943643;4119.134981653886;5850.444207800252;5934.139549765174;5942.851428714317;5960.5827592068135;5975.073863551156;5737.426257374396;5749.942500575108;5757.0788673811985;5757.625754325955;5774.653520788766;5735.053716136791;5755.53955683536;5756.884862302647;5768.451997060272;5772.913406298993;5615.634983726045;5640.097584386478;5648.971755141198;5651.971740141273;5655.066913959316;5671.404502527175;5774.0761478163295;5788.594798364074;5799.043157878903;5802.100674395476;5650.915236271377;5651.180578816131;5655.886882262414;5658.519025882846;5667.064934285797 22:26:50 INFO - 2015-11-13 22:26:50,019 DEBUG : BROWSER_OUTPUT: |5;yui.html;635.6989970192342;663.0910780946323;704.3379223529878;794.5074054086467;798.5847359373126;11923.463444145013;12173.513059477622;12223.572174973877;12254.1422100453;12257.570985015525;12542.310172940484;13263.27052012139;13264.535741249058;13266.071375003754;13272.933635331834;611.0589691874508;616.7563812294163;781.4100354232561;788.0897563314353;794.4359504751633;770.7302444144533;779.3648176735942;782.9373650108006;784.419529548136;784.8979632647748;805.5851236613149;814.1207495904409;815.3721634341554;818.0469752738053;818.2717381530413;625.6871564217892;633.0820310549722;803.8794180872886;840.7267638017669;853.0531110467376;613.3712944232153;618.3322012226785;620.8975519039353;623.0342968398963;623.0498489803041;12496.875031249661;12616.432260548298;12631.936840315831;12663.176893501894;12674.112812103156;11127.276727012799;11353.886461135447;11506.76986460266;11622.186446948717;11822.645320640395;9179.357444978854;9351.906480935171;9359.251259899193;9443.716688499288;9541.856872146924;2912.184588315275;3199.808011519316;3248.10677063807;3288.5560449339273;3299.736021118305;41937.79031104856;42344.788276058425;42408.36387454191;42612.3608145878;42714.35928461076;9442.763930901783;9479.76300592477;9525.952370238243;9528.666496672584;9587.808243835085;16940.491785246217;16975.405860794814;17094.059826709403;17103;17126.657466850844;6118.265808103056;6204.971315519313;6473.158489396348;6540.444062254666;6635.734570617121;3559.1280136366754;3591.6049234584175;3605.4231322988194;3625.12996880752;3658.213484100931;2775.153578158641;2781.4715204111153;2801.9159425217276;2804.0466241477993;2810.9297267568472;411.43633222485386;415.4619767401223;430.54147333090157;432.71873282366715;432.7511680783499;485.0759303526787;488.74340970989806;507.97206153661165;527.0302643136647;546.3498436860124;8275.684354496654;8508.149185081442;8709.956450217709;8852.778680533038;8858.468491890508;497.7038661996107;504.5811976059862;508.9770960306795;571.6884298057569;585.8798946216016;3541.3094446583186;3708.8331025103935;3743.794091324949;3921.5490218624655;3921.941170882439;47809;48697;48859.511404885496;48863.51136488661;48870.51129488731;44620.55379446164;44672;44915.775421122686;45026.77486612546;45512.544874551495;40997.180056398705;41154.1769164621;41597.1680566387;41920.37119443211;41957.79021104875;7367.300106489874;7534.962325188339;7695.422843286888;7699.641484512383;7776.144624091458;30799.692003080578;30813.22966925755;31504;31515.84242078775;32127.839360803046;36935.815320923226;37040.444393333586;37137.81431092935;40663.39004914869;40811.79594102011;6209.316975132641;6369.267534233622;6453.903191452226;6482.448991835558;6507.902381464187;9977.145873062433;10154.644587439405;10183;10235.590576376862;10372.896271037192;9603.519824008912;9726.416415015121;9893.35693179941;9906.950465247628;10241.283110182216;9543.143167049753;9652.324337296603;9761;9806.705798826046;9846.064623860722;9173.633054678005;9331.113544213289;9408.95295523518;9546.379485333431;9669;8545.188207120314;8789.736307910773;8872.86690699627;8888.511131887808;8930.106989301017;8051.355891528547;8353.791155220924;8481.321494280319;8657.480551166951;8726 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482410009__endTimestamp 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,020 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:26:50 INFO - 2015-11-13 22:26:50,021 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4757.08 Median:4856.30 stddev:501.89 (10.3%) stddev-sans-first:475.54 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: Values: 2653.7 2751.2 2764.6 2764.9 2769.3 4611.2 4735.0 4837.4 4852.1 4856.3 4737.3 4812.8 4817.5 4819.7 4823.7 4372.5 4427.2 4435.5 4540.8 4544.6 4288.2 4480.5 4485.0 4521.4 4573.3 4394.5 4396.1 4483.6 4495.3 4516.3 4426.6 4434.0 4450.0 4454.8 4473.6 4389.9 4401.7 4417.4 4443.5 4458.9 4492.1 4605.1 4635.8 4645.5 4727.7 5083.1 5089.8 5103.8 5106.1 5143.3 5216.1 5217.3 5225.6 5267.8 5269.7 4586.0 4655.0 4663.1 4665.3 4779.7 5334.9 5356.8 5366.4 5368.3 5410.9 5125.5 5130.8 5135.1 5135.7 5175.4 4970.5 5078.2 5082.4 5083.3 5211.5 5135.2 5135.9 5142.5 5142.8 5153.8 5092.7 5099.4 5103.9 5105.6 5132.7 4122.8 4208.6 4210.2 4284.8 4309.4 3755.3 3771.8 3774.5 3797.4 3804.8 4492.9 4493.4 4500.4 4505.4 4529.6 5012.5 5128.0 5184.2 5186.8 5289.0 4494.9 4499.5 4509.6 4513.3 4543.2 4599.9 4614.2 4614.3 4622.4 4649.1 4701.8 4773.9 4809.5 4815.1 4849.9 5175.8 5241.7 5242.4 5246.6 5246.7 4963.4 4968.7 4969.1 4969.4 4995.7 4915.9 5046.1 5050.2 5058.0 5196.4 5192.4 5194.9 5196.9 5197.2 5204.7 5026.1 5027.0 5027.5 5027.9 5073.1 4791.3 4891.3 4908.6 4910.3 5014.4 4957.7 4965.9 4977.1 4977.5 5006.3 5083.5 5093.3 5093.7 5098.2 5133.4 4752.5 4834.5 4875.8 4878.4 4946.9 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42412.01 Median:32504.26 stddev:69825.69 (214.8%) stddev-sans-first:69950.88 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: Values: 564.4 570.3 583.6 588.8 590.5 26333.1 26925.3 37640.6 37942.0 37999.2 40378.4 40889.0 40981.0 41039.0 41066.8 7024.2 7912.3 8136.5 8186.7 8187.1 6782.3 10168.3 10437.2 10446.3 10453.2 10265.2 10367.9 10374.5 10387.3 10391.7 7244.2 7415.5 10208.1 10326.6 10349.1 10101.1 10253.8 10261.5 10263.3 10264.9 37925.4 38379.0 38398.4 38469.8 38579.6 2786.7 2830.9 2869.6 3040.5 3436.3 27378.6 27692.7 28236.7 29290.6 30260.5 2883.9 2955.4 3007.6 3145.9 3255.7 217369.0 218911.0 218925.0 221023.0 221187.0 48665.0 49752.0 58283.4 58465.7 58477.1 67480.0 68453.7 68536.0 68553.3 68583.7 13687.6 13753.7 13773.0 13885.3 13905.7 9742.5 9762.6 9763.4 9779.0 9785.0 19047.5 19408.8 19537.8 19560.2 19641.0 7759.8 8000.1 8085.5 8103.3 8180.3 773.0 783.9 819.2 852.8 887.1 26412.9 26639.6 26647.2 26679.3 26691.5 881.1 927.1 948.8 1023.5 1051.9 13692.0 13816.7 13910.7 14115.7 14173.2 337137.0 344756.0 344774.0 344938.0 346367.0 48078.0 48517.8 48609.3 48658.8 48668.8 1152.3 1157.5 1164.4 1166.8 1167.0 25194.6 25778.4 26241.3 26263.2 26291.2 36476.6 37363.8 42506.1 43234.6 43261.6 214327.0 215381.0 215649.0 215868.0 215908.0 24752.1 24986.8 29017.3 29405.3 29412.0 37725.6 38429.6 38935.0 39727.4 39805.4 32167.4 32520.0 32938.3 33315.7 33501.0 32656.5 32803.2 32805.8 32882.7 33043.5 32488.5 32689.5 32985.3 33428.3 33472.8 28593.1 29431.0 30006.6 30231.4 30446.4 25154.0 25724.0 25866.2 25891.7 26185.9 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,022 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23983.96 Median:24626.93 stddev:69151.69 (280.8%) stddev-sans-first:69322.87 22:26:50 INFO - 2015-11-13 22:26:50,023 DEBUG : BROWSER_OUTPUT: Values: 333.4 333.9 345.7 346.6 347.7 12533.8 12968.7 15174.7 15176.5 16146.8 14626.3 15248.5 15519.1 15727.9 15731.4 4971.9 4973.1 5080.5 5080.5 5088.6 3573.2 3681.8 5127.2 5670.9 5913.4 5806.8 5819.3 5833.2 5852.0 5864.1 5722.5 5918.8 5933.3 5934.9 5941.0 5147.7 5168.4 5169.8 5200.9 5204.2 18519.7 19111.0 19135.9 19314.3 19870.3 1694.1 1793.9 1809.2 1825.1 1872.8 12256.3 12375.6 12414.6 12513.5 13479.9 1791.4 1876.8 1925.6 1932.1 1972.3 60490.7 62335.0 62394.4 62750.4 62848.7 15177.1 15376.2 15391.8 15407.2 15421.5 22555.8 22732.2 22854.4 22860.5 22898.0 7926.0 7964.0 7983.4 8068.6 8381.1 6927.6 6957.9 6993.8 7011.4 7019.8 7343.9 7464.9 7496.9 7498.8 7511.1 998.6 1006.1 1007.7 2025.3 2895.8 387.6 393.0 402.6 414.8 421.6 9189.6 9896.1 10003.1 10254.5 10271.8 403.9 412.8 416.9 420.9 425.7 5382.6 5575.6 5621.8 5722.3 5744.8 335053.0 337619.0 338311.0 497978.0 546001.0 60169.7 62954.7 73644.0 74849.0 75222.0 427.2 438.6 439.4 441.3 442.4 9117.2 9247.8 9355.0 9410.2 9452.7 31797.2 32377.4 32515.7 32807.0 33325.7 42903.4 43027.4 43453.8 43915.8 44282.0 7490.9 7492.0 7690.6 7695.9 7728.6 10842.7 10940.2 11030.8 11055.2 11134.9 9848.8 9963.3 10111.1 10153.8 10159.8 7806.8 9834.6 9884.8 9942.2 10165.2 8121.2 8507.6 9415.4 9574.6 9586.3 7254.0 7301.6 7408.4 7419.6 7424.6 9340.9 9415.9 9627.2 9651.6 9652.3 22:26:50 INFO - 2015-11-13 22:26:50,023 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,023 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5105.89 Median:6479.96 stddev:2682.39 (41.4%) stddev-sans-first:2674.41 22:26:50 INFO - 2015-11-13 22:26:50,024 DEBUG : BROWSER_OUTPUT: Values: 1269.6 1642.7 1683.5 1708.2 1730.6 6426.6 6997.2 7124.4 7138.0 7147.9 7285.4 7398.1 7402.6 7402.6 7408.9 1791.5 1852.1 2089.8 2096.8 2097.7 2115.2 2127.0 2130.0 2131.1 2131.7 2032.6 2062.8 2075.7 2076.6 2078.5 1773.5 1803.9 2014.4 2056.7 2056.9 2051.0 2056.1 2080.1 2080.5 2081.8 7287.2 7287.9 7288.8 7314.3 7335.0 4352.1 4442.7 4442.9 4446.1 4449.0 2838.0 2885.7 2888.4 2925.7 2951.7 924.3 932.1 934.1 968.1 977.7 9799.0 9827.9 9841.1 9890.2 9915.5 4051.1 4058.5 4150.9 4192.4 4222.2 8144.4 8164.4 8175.1 8187.8 8188.5 4373.1 4393.0 4395.0 4399.5 4400.1 3962.7 3966.4 3971.4 3989.1 3989.9 3468.3 3518.3 3521.1 3522.2 3544.0 1060.6 1062.5 1064.5 1074.4 1078.7 836.8 844.0 952.9 1154.6 1155.2 5778.6 6789.9 6873.0 6945.4 6946.2 579.1 585.7 590.8 593.7 601.0 5325.1 5340.6 5357.4 5361.0 5375.4 8620.8 8995.7 9031.6 9036.3 9052.9 8845.1 8848.4 8864.0 8894.5 8906.4 6771.4 6795.3 6959.2 7037.5 7042.0 6644.8 6654.9 6666.3 6686.8 6686.8 7806.8 7956.7 7969.3 7978.6 7988.2 8064.2 8253.6 8316.3 8419.9 8472.7 6555.4 6567.1 6603.9 6618.1 6637.8 7108.5 7167.0 7174.5 7175.0 7191.6 6533.3 6541.6 6677.7 6724.0 6919.1 6636.1 6723.3 6748.5 6795.8 6834.0 5545.5 5685.7 6618.3 6726.5 6738.4 6007.9 6075.5 6082.0 6106.6 6124.0 6157.9 6181.5 6193.4 6242.3 6242.4 22:26:50 INFO - 2015-11-13 22:26:50,024 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,025 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4742.53 Median:5309.69 stddev:1398.60 (26.3%) stddev-sans-first:1362.14 22:26:50 INFO - 2015-11-13 22:26:50,025 DEBUG : BROWSER_OUTPUT: Values: 297.0 301.5 302.4 306.8 310.4 5350.5 5400.2 5443.3 5469.0 5522.4 5268.9 5427.2 5434.9 5446.3 5458.9 4133.9 4191.6 4195.3 4203.0 4207.9 3963.7 4027.8 4051.5 4165.3 4185.9 4117.6 4147.5 4149.0 4153.8 4171.7 4154.4 4155.3 4156.7 4160.3 4163.8 3627.3 3647.4 3650.4 3657.6 3659.8 5125.4 5251.4 5253.2 5254.3 5256.6 4821.0 4829.6 4833.3 4834.5 4835.5 5707.1 5710.5 5712.3 5713.5 5719.9 3776.1 3866.8 3882.7 4001.4 4016.8 5989.3 5997.8 6004.0 6005.5 6011.6 4090.2 4119.2 4119.4 4121.6 4127.1 4184.9 4189.3 4192.4 4194.7 4197.0 4633.5 4766.9 4771.9 4777.1 4794.5 5690.5 5691.4 5701.6 5702.3 5706.9 1470.6 1484.6 1486.5 1490.3 1490.5 1004.3 1007.4 1009.9 1013.1 1028.3 5036.0 5037.4 5039.1 5048.2 5051.8 5924.5 5997.1 5998.3 5998.3 6004.4 5049.8 5052.7 5053.8 5054.0 5055.3 3122.1 3177.5 3207.3 3209.8 3217.8 5595.6 5604.6 5605.0 5610.0 5610.4 6087.8 6090.3 6092.3 6094.5 6096.7 5482.5 5588.3 5601.1 5601.3 5606.3 5912.2 5914.9 5915.3 5915.5 5920.2 5589.9 5685.5 5744.7 5759.7 5776.1 5621.7 5643.9 5647.5 5649.9 5658.4 4087.9 4091.0 4115.3 4118.4 4119.1 5850.4 5934.1 5942.9 5960.6 5975.1 5737.4 5749.9 5757.1 5757.6 5774.7 5735.1 5755.5 5756.9 5768.5 5772.9 5615.6 5640.1 5649.0 5652.0 5655.1 5671.4 5774.1 5788.6 5799.0 5802.1 5650.9 5651.2 5655.9 5658.5 5667.1 22:26:50 INFO - 2015-11-13 22:26:50,025 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,025 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12151.36 Median:518.00 stddev:13923.18 (2687.9%) stddev-sans-first:13935.38 22:26:50 INFO - 2015-11-13 22:26:50,025 DEBUG : BROWSER_OUTPUT: Values: 635.7 663.1 704.3 794.5 798.6 11923.5 12173.5 12223.6 12254.1 12257.6 12542.3 13263.3 13264.5 13266.1 13272.9 611.1 616.8 781.4 788.1 794.4 770.7 779.4 782.9 784.4 784.9 805.6 814.1 815.4 818.0 818.3 625.7 633.1 803.9 840.7 853.1 613.4 618.3 620.9 623.0 623.0 12496.9 12616.4 12631.9 12663.2 12674.1 11127.3 11353.9 11506.8 11622.2 11822.6 9179.4 9351.9 9359.3 9443.7 9541.9 2912.2 3199.8 3248.1 3288.6 3299.7 41937.8 42344.8 42408.4 42612.4 42714.4 9442.8 9479.8 9526.0 9528.7 9587.8 16940.5 16975.4 17094.1 17103.0 17126.7 6118.3 6205.0 6473.2 6540.4 6635.7 3559.1 3591.6 3605.4 3625.1 3658.2 2775.2 2781.5 2801.9 2804.0 2810.9 411.4 415.5 430.5 432.7 432.8 485.1 488.7 508.0 527.0 546.3 8275.7 8508.1 8710.0 8852.8 8858.5 497.7 504.6 509.0 571.7 585.9 3541.3 3708.8 3743.8 3921.5 3921.9 47809.0 48697.0 48859.5 48863.5 48870.5 44620.6 44672.0 44915.8 45026.8 45512.5 40997.2 41154.2 41597.2 41920.4 41957.8 7367.3 7535.0 7695.4 7699.6 7776.1 30799.7 30813.2 31504.0 31515.8 32127.8 36935.8 37040.4 37137.8 40663.4 40811.8 6209.3 6369.3 6453.9 6482.4 6507.9 9977.1 10154.6 10183.0 10235.6 10372.9 9603.5 9726.4 9893.4 9907.0 10241.3 9543.1 9652.3 9761.0 9806.7 9846.1 9173.6 9331.1 9409.0 9546.4 9669.0 8545.2 8789.7 8872.9 8888.5 8930.1 8051.4 8353.8 8481.3 8657.5 8726.0 22:26:50 INFO - 2015-11-13 22:26:50,026 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:26:50 INFO - 2015-11-13 22:26:50,027 DEBUG : BROWSER_OUTPUT: 22:26:50 INFO - 2015-11-13 22:26:50,755 INFO : Browser exited with error code: 0 22:26:50 INFO - 2015-11-13 22:26:50,780 INFO : Completed test dromaeo_css (00:18:37) 22:26:50 INFO - 2015-11-13 22:26:50,781 INFO : Starting test kraken 22:26:50 INFO - 2015-11-13 22:26:50,781 DEBUG : operating with platform_type : linux_ 22:26:50 INFO - 2015-11-13 22:26:50,781 INFO : Initialising browser for kraken test... 22:26:50 INFO - 2015-11-13 22:26:50,787 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVkaHbO/profile http://localhost:59334/getInfo.html 22:26:54 INFO - 2015-11-13 22:26:54,724 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:26:54 INFO - 2015-11-13 22:26:54,724 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:26:54 INFO - 2015-11-13 22:26:54,724 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:26:54 INFO - 2015-11-13 22:26:54,724 DEBUG : BROWSER_OUTPUT: __metrics 22:26:54 INFO - 2015-11-13 22:26:54,846 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:26:56 INFO - 2015-11-13 22:26:56,006 INFO : Browser initialized. 22:26:56 INFO - 2015-11-13 22:26:56,006 INFO : Running cycle 1/1 for kraken test... 22:26:56 INFO - 2015-11-13 22:26:56,006 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVkaHbO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:27:07 INFO - 2015-11-13 22:27:07,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 140492800 22:27:07 INFO - 2015-11-13 22:27:07,929 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-13 22:27:10,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59334/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:11 INFO - 2015-11-13 22:27:11,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 179474432 22:27:11 INFO - 2015-11-13 22:27:11,112 DEBUG : BROWSER_OUTPUT: 22:27:13 INFO - 2015-11-13 22:27:13,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59334/tests/kraken/driver.html?testName=audio-dft) 22:27:14 INFO - 2015-11-13 22:27:14,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 170102784 22:27:14 INFO - 2015-11-13 22:27:14,368 DEBUG : BROWSER_OUTPUT: 22:27:17 INFO - 2015-11-13 22:27:17,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59334/tests/kraken/driver.html?testName=audio-fft) 22:27:17 INFO - 2015-11-13 22:27:17,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 151699456 22:27:17 INFO - 2015-11-13 22:27:17,899 DEBUG : BROWSER_OUTPUT: 22:27:19 INFO - 2015-11-13 22:27:19,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59334/tests/kraken/driver.html?testName=audio-oscillator) 22:27:20 INFO - 2015-11-13 22:27:20,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 153284608 22:27:20 INFO - 2015-11-13 22:27:20,484 DEBUG : BROWSER_OUTPUT: 22:27:22 INFO - 2015-11-13 22:27:22,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:23 INFO - 2015-11-13 22:27:23,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 153980928 22:27:23 INFO - 2015-11-13 22:27:23,250 DEBUG : BROWSER_OUTPUT: 22:27:26 INFO - 2015-11-13 22:27:26,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59334/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:26 INFO - 2015-11-13 22:27:26,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 154316800 22:27:26 INFO - 2015-11-13 22:27:26,812 DEBUG : BROWSER_OUTPUT: 22:27:30 INFO - 2015-11-13 22:27:30,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59334/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:30 INFO - 2015-11-13 22:27:30,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 155635712 22:27:30 INFO - 2015-11-13 22:27:30,843 DEBUG : BROWSER_OUTPUT: 22:27:33 INFO - 2015-11-13 22:27:33,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59334/tests/kraken/driver.html?testName=json-parse-financial) 22:27:34 INFO - 2015-11-13 22:27:34,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 22:27:34 INFO - 2015-11-13 22:27:34,288 DEBUG : BROWSER_OUTPUT: 22:27:36 INFO - 2015-11-13 22:27:36,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:36 INFO - 2015-11-13 22:27:36,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 165736448 22:27:36 INFO - 2015-11-13 22:27:36,623 DEBUG : BROWSER_OUTPUT: 22:27:38 INFO - 2015-11-13 22:27:38,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:39 INFO - 2015-11-13 22:27:39,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 163844096 22:27:39 INFO - 2015-11-13 22:27:39,119 DEBUG : BROWSER_OUTPUT: 22:27:41 INFO - 2015-11-13 22:27:41,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:41 INFO - 2015-11-13 22:27:41,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 179097600 22:27:41 INFO - 2015-11-13 22:27:41,840 DEBUG : BROWSER_OUTPUT: 22:27:44 INFO - 2015-11-13 22:27:44,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:44 INFO - 2015-11-13 22:27:44,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 180776960 22:27:44 INFO - 2015-11-13 22:27:44,936 DEBUG : BROWSER_OUTPUT: 22:27:47 INFO - 2015-11-13 22:27:47,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:48 INFO - 2015-11-13 22:27:48,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 180686848 22:27:48 INFO - 2015-11-13 22:27:48,059 DEBUG : BROWSER_OUTPUT: 22:27:49 INFO - 2015-11-13 22:27:49,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59334/tests/kraken/driver.html?testName=ai-astar) 22:27:50 INFO - 2015-11-13 22:27:50,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 240451584 22:27:50 INFO - 2015-11-13 22:27:50,059 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,059 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:50 INFO - 2015-11-13 22:27:50,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:50 INFO - 2015-11-13 22:27:50,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;105;110;112;111;98;111;113;110 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;139;163;165;131;155;151;134;171;130 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;160;159;160;161;161;160 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;79;93;73;74;72;96;92;73 22:27:50 INFO - 2015-11-13 22:27:50,060 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;133;91;91;91;132;90;91;125 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;109;109;109;109;109 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;146;147;148;146;146 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;73;71;71;73;80;69;69 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;67;68;68;68;67;67;68 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;84;84;84;92;83;85;85;84 22:27:50 INFO - 2015-11-13 22:27:50,061 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;119;122;124;119;120;126;124;119 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;144;146;143;147;133;150;143;138;138 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;67;67;68;67;66;67;67;68 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,971 22:27:50 INFO - 2015-11-13 22:27:50,062 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:27:50 INFO - 2015-11-13 22:27:50,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482470057__endTimestamp 22:27:50 INFO - 2015-11-13 22:27:50,063 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:50 INFO - 2015-11-13 22:27:50,066 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:27:50 INFO - 2015-11-13 22:27:50,066 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,066 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:4.70 (4.2%) stddev-sans-first:4.95 22:27:50 INFO - 2015-11-13 22:27:50,066 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 105.0 110.0 112.0 111.0 98.0 111.0 113.0 110.0 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.50 stddev:14.89 (9.7%) stddev-sans-first:15.75 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: Values: 152.0 139.0 163.0 165.0 131.0 155.0 151.0 134.0 171.0 130.0 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 161.0 160.0 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:76.50 stddev:9.81 (12.8%) stddev-sans-first:10.09 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 79.0 93.0 73.0 74.0 72.0 96.0 92.0 73.0 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:91.00 stddev:18.96 (20.8%) stddev-sans-first:19.63 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 133.0 91.0 91.0 91.0 132.0 90.0 91.0 125.0 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,067 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:27:50 INFO - 2015-11-13 22:27:50,068 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 22:27:50 INFO - 2015-11-13 22:27:50,068 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,068 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 146.0 147.0 148.0 146.0 146.0 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:3.11 (4.3%) stddev-sans-first:3.30 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 73.0 71.0 71.0 73.0 80.0 69.0 69.0 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 22:27:50 INFO - 2015-11-13 22:27:50,069 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 68.0 68.0 68.0 67.0 67.0 68.0 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.54 (3.0%) stddev-sans-first:2.69 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 84.0 84.0 84.0 92.0 83.0 85.0 85.0 84.0 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.00 stddev:3.01 (2.5%) stddev-sans-first:2.86 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 119.0 122.0 124.0 119.0 120.0 126.0 124.0 119.0 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:143.50 stddev:5.26 (3.7%) stddev-sans-first:5.27 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: Values: 137.0 144.0 146.0 143.0 147.0 133.0 150.0 143.0 138.0 138.0 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 68.0 67.0 66.0 67.0 67.0 68.0 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:50 INFO - 2015-11-13 22:27:50,070 DEBUG : BROWSER_OUTPUT: 22:27:51 INFO - 2015-11-13 22:27:51,023 INFO : Browser exited with error code: 0 22:27:51 INFO - 2015-11-13 22:27:51,076 INFO : Completed test kraken (00:01:00) 22:27:51 INFO - 2015-11-13 22:27:51,076 INFO : Starting test v8_7 22:27:51 INFO - 2015-11-13 22:27:51,076 DEBUG : operating with platform_type : linux_ 22:27:51 INFO - 2015-11-13 22:27:51,076 INFO : Initialising browser for v8_7 test... 22:27:51 INFO - 2015-11-13 22:27:51,082 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJchdjG/profile http://localhost:59334/getInfo.html 22:27:54 INFO - 2015-11-13 22:27:54,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:27:54 INFO - 2015-11-13 22:27:54,948 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:27:54 INFO - 2015-11-13 22:27:54,948 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:27:54 INFO - 2015-11-13 22:27:54,948 DEBUG : BROWSER_OUTPUT: __metrics 22:27:55 INFO - 2015-11-13 22:27:55,093 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:56 INFO - 2015-11-13 22:27:56,301 INFO : Browser initialized. 22:27:56 INFO - 2015-11-13 22:27:56,301 INFO : Running cycle 1/1 for v8_7 test... 22:27:56 INFO - 2015-11-13 22:27:56,302 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJchdjG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:28:08 INFO - 2015-11-13 22:28:08,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 140652544 22:28:08 INFO - 2015-11-13 22:28:08,220 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59334/tests/v8_7/run.html (next: http://localhost:59334/tests/v8_7/run.html) 22:28:29 INFO - 2015-11-13 22:28:29,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 440590336 22:28:29 INFO - 2015-11-13 22:28:29,858 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:28:29 INFO - 2015-11-13 22:28:29,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:28:29 INFO - 2015-11-13 22:28:29,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:28:29 INFO - 2015-11-13 22:28:29,859 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:28:29 INFO - 2015-11-13 22:28:29,859 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1055292774425 22:28:29 INFO - 2015-11-13 22:28:29,859 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.131498470948 22:28:29 INFO - 2015-11-13 22:28:29,859 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |5;Earley;809.0614886731391 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |6;Boyer;11788.235294117647 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |8;Splay;606.6465256797583 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 22:28:29 INFO - 2015-11-13 22:28:29,860 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482509856__endTimestamp 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.11 Median:163.11 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: Values: 163.1 22:28:29 INFO - 2015-11-13 22:28:29,861 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,862 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.13 Median:191.13 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,862 DEBUG : BROWSER_OUTPUT: Values: 191.1 22:28:29 INFO - 2015-11-13 22:28:29,862 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,862 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: Values: 278.7 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: Values: 5020.0 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,863 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: Values: 1988.1 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: Values: 809.1 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: Values: 11788.2 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: Values: 26868.4 22:28:29 INFO - 2015-11-13 22:28:29,864 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.65 Median:606.65 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: Values: 606.6 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: Values: 4822.1 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:28:29 INFO - 2015-11-13 22:28:29,865 DEBUG : BROWSER_OUTPUT: 22:28:30 INFO - 2015-11-13 22:28:30,763 INFO : Browser exited with error code: 0 22:28:30 INFO - 2015-11-13 22:28:30,775 INFO : Completed test v8_7 (00:00:39) 22:28:30 INFO - 2015-11-13 22:28:30,888 INFO : Completed test suite (00:20:17) 22:28:30 INFO - 2015-11-13 22:28:30,888 DEBUG : Working with test: dromaeo_css 22:28:30 INFO - 2015-11-13 22:28:30,888 DEBUG : Generating results file: dromaeo_css 22:28:30 INFO - 2015-11-13 22:28:30,889 DEBUG : Working with test: kraken 22:28:30 INFO - 2015-11-13 22:28:30,889 DEBUG : Generating results file: kraken 22:28:30 INFO - 2015-11-13 22:28:30,889 INFO : javascript benchmark 22:28:30 INFO - 2015-11-13 22:28:30,890 DEBUG : Working with test: v8_7 22:28:30 INFO - 2015-11-13 22:28:30,890 DEBUG : Generating results file: v8_7 22:28:30 INFO - 2015-11-13 22:28:30,890 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:30 INFO - 2015-11-13 22:28:30,952 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:28:30 INFO - 2015-11-13 22:28:30,952 DEBUG : process_Request line: dromaeo_css 6262.74 graph.html#tests=[[72,132,35]] 22:28:30 INFO - 2015-11-13 22:28:30,953 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:30 INFO - 2015-11-13 22:28:30,980 DEBUG : process_Request line: kraken 1506.90 graph.html#tests=[[232,132,35]] 22:28:30 INFO - 2015-11-13 22:28:30,980 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:31 INFO - 2015-11-13 22:28:31,018 DEBUG : process_Request line: v8_7 19865.31 graph.html#tests=[[230,132,35]] 22:28:31 INFO - 2015-11-13 22:28:31,020 INFO : javascript benchmark 22:28:31 INFO - 2015-11-13 22:28:31,023 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.3849048505507, 333.93308379726767, 345.72687576814303, 346.64122633074743, 347.6992401572639, 12533.811992820116, 12968.74062518749, 15174.696506069871, 15176.468823591176, 16146.757798633014, 14626.341814618341, 15248.466303679374, 15519.146446945413, 15727.921360393182, 15731.449399271029, 4971.850844474671, 4973.079980203655, 5080.517350851663, 5080.517350851663, 5088.567471764904, 3573.213892943548, 3681.7975011374365, 5127.230915362707, 5670.858228544278, 5913.408659134096, 5806.767729290823, 5819.272590926134, 5833.183354330397, 5851.970740146315, 5864.091065884794, 5722.484976352128, 5918.7928422505, 5933.288005439354, 5934.8813023739285, 5941.0, 5147.716875571842, 5168.405633352138, 5169.819056333048, 5200.869978250574, 5204.193350030751, 18519.72220416695, 19111.0, 19135.904320478447, 19314.32399865998, 19870.3045393412, 1694.1190580897864, 1793.8923664580168, 1809.1677828199045, 1825.12394050855, 1872.803355647651, 12256.325902075383, 12375.566855160116, 12414.565490207799, 12513.499460021589, 13479.932600337033, 1791.408835084419, 1876.774787025552, 1925.6052509235574, 1932.0726051495221, 1972.2702600037935, 60490.69754651243, 62335.0, 62394.37605623931, 62750.37249627491, 62848.68575657092, 15177.089374637337, 15376.15431151275, 15391.846081539265, 15407.152606606744, 15421.460248891459, 22555.774442255697, 22732.20437284687, 22854.42863928382, 22860.542789144125, 22898.0, 7926.048874135141, 7963.960180199062, 7983.441159118806, 8068.636911339004, 8381.07808141104, 6927.618980955995, 6957.860842783217, 6993.755218567428, 7011.368976792011, 7019.789406317716, 7343.926560734431, 7464.85070298591, 7496.925030749731, 7498.812529686692, 7511.06111736033, 998.5756053677159, 1006.1146191351564, 1007.6825799873163, 2025.2810252360493, 2895.7837708162624, 387.5814120749584, 393.02137677183606, 402.5994135834863, 414.7822393243511, 421.6394982290159, 9189.63241470347, 9896.059874312074, 10003.099721025143, 10254.487275636338, 10271.794564108675, 403.87681757064377, 412.8162967479503, 416.8811888611731, 420.93896385024, 425.69775459424153, 5382.623216374895, 5575.553955683536, 5621.831345059655, 5722.284714410699, 5744.770209191669, 335053.0, 337619.0, 338311.0, 497978.0, 546001.0, 60169.699151504836, 62954.68522657357, 73644.0, 74849.0, 75222.0, 427.1734194333912, 438.58991842627245, 439.4353256066004, 441.3357896365949, 442.44252242174446, 9117.179453849185, 9247.76880577991, 9355.017723138972, 9410.153086222273, 9452.669156579486, 31797.20506987344, 32377.35245295128, 32515.674843251265, 32807.0, 33325.66674333226, 42903.35644965265, 43027.35458968055, 43453.78273108614, 43915.78042109769, 44282.0, 7490.887636685345, 7491.962540187482, 7690.577018263825, 7695.88456173169, 7728.574928378993, 10842.728931776768, 10940.234183607072, 11030.779384412428, 11055.22613417053, 11134.888651113386, 9848.803023939625, 9963.25275604318, 10111.090001899864, 10153.796924061626, 10159.84760228612, 7806.804829879298, 9834.60661573529, 9884.802303953737, 9942.15491683215, 10165.18678505703, 8121.187881211831, 8507.617157227816, 9415.435073895589, 9574.617015319309, 9586.328956972944, 7253.963730181315, 7301.598412087386, 7408.444366672629, 7419.629018549159, 7424.591647459441, 9340.879094508702, 9415.858762118436, 9627.229821614394, 9651.565679544297, 9652.324337296603], "dojo.html": [2653.7346265373467, 2751.174647605718, 2764.6129541864157, 2764.889404423823, 2769.293830073332, 4611.239145540982, 4735.0, 4837.3711417515715, 4852.053849499349, 4856.2958371036175, 4737.289406589005, 4812.759362031902, 4817.518248175181, 4819.662623616348, 4823.734694591796, 4372.519022907478, 4427.180971520263, 4435.534268901751, 4540.79566419512, 4544.568266014723, 4288.16380805743, 4480.507144214133, 4484.955150448486, 4521.434820647419, 4573.3368661544055, 4394.4946331172005, 4396.076823866976, 4483.618892394151, 4495.348174514677, 4516.322551617251, 4426.645868330525, 4433.955660443419, 4450.043240703232, 4454.821807127711, 4473.552644735533, 4389.934150987738, 4401.669874759374, 4417.403650507173, 4443.533428989974, 4458.8885277867985, 4492.146492166478, 4605.078984203173, 4635.791389387486, 4645.465771436295, 4727.692699974525, 5083.11045567028, 5089.821856235014, 5103.8468845934685, 5106.106431374495, 5143.305653736735, 5216.061109000379, 5217.34783152106, 5225.608079394061, 5267.762950667229, 5269.710165940872, 4585.954140458586, 4654.976725116353, 4663.090697314059, 4665.346851440801, 4779.713217206979, 5334.866628334323, 5356.7857285708915, 5366.436524164985, 5368.302120724359, 5410.864728381822, 5125.538701516882, 5130.820421285237, 5135.050015747099, 5135.717535535581, 5175.378954525406, 4970.453250142481, 5078.238264260317, 5082.415522214993, 5083.313752643419, 5211.478852114758, 5135.152699804565, 5135.948640513547, 5142.51146141116, 5142.794288228504, 5153.845384638467, 5092.719900405439, 5099.413567439718, 5103.897922041539, 5105.642605017687, 5132.692038477703, 4122.835086596562, 4208.621224089847, 4210.157968406331, 4284.764337961442, 4309.353596960418, 3755.2677227940835, 3771.773693578339, 3774.5470543534952, 3797.430385442206, 3804.752691075071, 4492.932606010912, 4493.415855938707, 4500.437445319335, 4505.414296141546, 4529.637628989739, 5012.523810238022, 5127.974360128175, 5184.196449550326, 5186.766595503212, 5288.9735551322765, 4494.910101797946, 4499.482559505634, 4509.571590698878, 4513.255312873404, 4543.1822271990695, 4599.885002874955, 4614.238650622677, 4614.307853821953, 4622.422197225347, 4649.070185962821, 4701.835435759732, 4773.928391074067, 4809.5430934061205, 4815.085133824702, 4849.927251091307, 5175.767090480862, 5241.659292145999, 5242.449542798104, 5246.580273578181, 5246.658967167122, 4963.354763880817, 4968.726720030433, 4969.055879382906, 4969.428515720739, 4995.700257984533, 4915.926261106015, 5046.142155833591, 5050.242463630485, 5058.0, 5196.4283928767045, 5192.402873669576, 5194.948050519446, 5196.948030519798, 5197.194434862602, 5204.739763011758, 5026.095302845377, 5027.01973115239, 5027.472115427974, 5027.949720502895, 5073.137566613758, 4791.329213910125, 4891.31521586971, 4908.6073114151495, 4910.337104490848, 5014.398272207359, 4957.7273249971595, 4965.900681986413, 4977.104121258209, 4977.4773648767805, 5006.299118123538, 5083.491650834887, 5093.312402825572, 5093.71984540839, 5098.1588037973315, 5133.435322114639, 4752.52474752522, 4834.540718631724, 4875.829345972874, 4878.438979517259, 4946.851594452172], "mootools.html": [1269.5746924780199, 1642.6632540329233, 1683.4949515145454, 1708.2142214581293, 1730.5760088778252, 6426.614403135809, 6997.230304666489, 7124.394426473756, 7137.964310178449, 7147.892781608267, 7285.41716662667, 7398.149212840525, 7402.555846649205, 7402.629868506567, 7408.925910740891, 1791.4804706635125, 1852.0832188066927, 2089.83281337493, 2096.811286984171, 2097.6958341040618, 2115.249086574267, 2126.9680954785613, 2129.957400851982, 2131.126238242321, 2131.6589345704692, 2032.583320419318, 2062.83497320214, 2075.688646702999, 2076.6262072826885, 2078.4699901525164, 1773.5477453249403, 1803.9188236529387, 2014.355406269994, 2056.6709326507835, 2056.8868712220824, 2051.0, 2056.1364227024687, 2080.1055546115163, 2080.5110798962232, 2081.7814129516487, 7287.161976372679, 7287.9271207287775, 7288.8177795555, 7314.305141011649, 7334.963325183393, 4352.086061926999, 4442.666799990014, 4442.93335599963, 4446.133004064209, 4449.0, 2837.957430638542, 2885.6825749167574, 2888.42231553688, 2925.6928022557536, 2951.6900725423734, 924.3113880159324, 932.0958670090001, 934.0845970948441, 968.1093394077466, 977.7164622259608, 9799.0, 9827.852582211273, 9841.114299712988, 9890.20878329739, 9915.504224788803, 4051.108756073659, 4058.5332686741403, 4150.937735933963, 4192.350185721218, 4222.218889505451, 8144.389170812213, 8164.428490005761, 8175.14161013097, 8187.83624327522, 8188.549629770419, 4373.081652852873, 4392.978035109804, 4395.0, 4399.450068741407, 4400.119976004812, 3962.742421742635, 3966.424868394067, 3971.3645816669773, 3989.1423343981182, 3989.880303590839, 3468.2890007548895, 3518.296340731864, 3521.1373213562842, 3522.2075033117344, 3544.043108360728, 1060.596973150198, 1062.5165549675035, 1064.5475672839168, 1074.4198133008088, 1078.7249251440833, 836.8117173636005, 843.9831203375898, 952.9285303602257, 1154.5958914380067, 1155.2433156282648, 5778.624389414675, 6789.93210067893, 6873.037774711544, 6945.444364450933, 6946.16646002483, 579.1486514823204, 585.689584520205, 590.8050343386672, 593.6764463367475, 601.0233370772495, 5325.147976323769, 5340.572754179656, 5357.383900851374, 5361.0, 5375.381831089397, 8620.78448038804, 8995.730128096167, 9031.63873445068, 9036.27709783229, 9052.8642070369, 8845.071267516947, 8848.380613357003, 8864.0, 8894.510801905957, 8906.421082629608, 6771.424428923498, 6795.320467953264, 6959.164900211906, 7037.472189585802, 7042.049323341385, 6644.767433139817, 6654.933450665431, 6666.300038495888, 6686.7993960181275, 6686.83282917931, 7806.765797026098, 7956.721514746956, 7969.3226075784205, 7978.601069946596, 7988.161243069627, 8064.233897779702, 8253.587320634064, 8316.334693224648, 8419.873701894354, 8472.66109355619, 6555.4427873631275, 6567.146270984741, 6603.900941485786, 6618.146918862726, 6637.838378283877, 7108.537945033556, 7166.964165179141, 7174.461915356264, 7175.0, 7191.568505889663, 6533.314002029909, 6541.6402097885075, 6677.69950352245, 6723.966380168068, 6919.100516932766, 6636.1373021508825, 6723.327667233433, 6748.460123190035, 6795.830104247236, 6833.965830170818, 5545.500904918576, 5685.71571421419, 6618.2719900811835, 6726.529142959946, 6738.427233684995, 6007.90988135187, 6075.483583895419, 6081.966065768742, 6106.57253992234, 6123.969380153071, 6157.907631385443, 6181.505479561714, 6193.411625895533, 6242.313345531897, 6242.375762423903], "ext.html": [564.3566334378809, 570.3241658634518, 583.594401890686, 588.7527238559804, 590.5452801342964, 26333.078342258024, 26925.326866828338, 37640.62359376402, 37942.0, 37999.24001519968, 40378.394324085166, 40889.0, 40981.0, 41039.0, 41066.79466602663, 7024.157101147869, 7912.327452166558, 8136.471129376601, 8186.672533098669, 8187.0994190638985, 6782.321767823203, 10168.288219824615, 10437.165026797838, 10446.320989135682, 10453.163746900267, 10265.230107741912, 10367.89632103677, 10374.533146008447, 10387.324823886462, 10391.740206494822, 7244.203137654854, 7415.5179913306, 10208.132308753764, 10326.638567650096, 10349.068583827417, 10101.141402980755, 10253.84619230712, 10261.538230779634, 10263.281570290008, 10264.89735102647, 37925.43111853324, 38379.0, 38398.424023639665, 38469.80765096185, 38579.614203857884, 2786.6656001279975, 2830.8584570771586, 2869.5982562441277, 3040.467918114321, 3436.3127374525193, 27378.589321160198, 27692.72307276942, 28236.717632823613, 29290.56064159018, 30260.54609180864, 2883.870225839821, 2955.3645966117174, 3007.5639032340405, 3145.889893853704, 3255.739540836751, 217369.0, 218911.0, 218925.0, 221022.9999999984, 221187.0, 48665.0, 49752.0, 58283.41716582865, 58465.70767146137, 58477.12284315738, 67480.0, 68453.65773171102, 68536.0, 68553.31446685469, 68583.65708171527, 13687.589372318846, 13753.656158596115, 13773.03588748778, 13885.305734713224, 13905.652358691113, 9742.46416447088, 9762.609495620096, 9763.414195148314, 9779.0, 9785.0, 19047.52381190481, 19408.80591194098, 19537.80462195388, 19560.21759129619, 19641.0, 7759.844803103906, 8000.119986801447, 8085.514869107872, 8103.270705636521, 8180.263776260165, 772.9806754831175, 783.9372850171973, 819.2135549872071, 852.8123812761182, 887.0995939121797, 26412.867935660197, 26639.600405993537, 26647.200583982125, 26679.33301667474, 26691.46617067648, 881.0704706534667, 927.1284992107397, 948.7580666929889, 1023.5496381592076, 1051.9322887269427, 13691.973102017388, 13816.723665526633, 13910.652233694238, 14115.71768564623, 14173.22047287409, 337137.0, 344756.0, 344774.0, 344938.0, 346367.0, 48078.0, 48517.75741121272, 48609.270860936405, 48658.75670621624, 48668.756656216494, 1152.2683096233952, 1157.5427706056062, 1164.4236103129006, 1166.8016437205695, 1167.0255336793873, 25194.62208066917, 25778.355541110872, 26241.343966400993, 26263.21210363692, 26291.21126366212, 36476.63523364838, 37363.81318093501, 42506.14987700291, 43234.56765432305, 43261.567384325754, 214327.0, 215381.0, 215649.0, 215868.0, 215908.0, 24752.133675321278, 24986.750132499168, 29017.274568135967, 29405.264868377606, 29412.0, 37725.62274377221, 38429.6157038426, 38935.0, 39727.404088938114, 39805.40291895682, 32167.356652866343, 32520.0, 32938.341233175684, 33315.66684333126, 33501.0, 32656.510152348208, 32803.17992050122, 32805.83597082095, 32882.671173288916, 33043.504347434326, 32488.51267230946, 32689.509657355633, 32985.34029319448, 33428.33143337071, 33472.824266422605, 28593.14220573386, 29431.0, 30006.649700763082, 30231.395372092877, 30446.391072178874, 25154.0, 25724.0, 25866.224013279632, 25891.741082588935, 26185.869070654524], "prototype.html": [296.98366589837576, 301.51456155589494, 302.4374663126585, 306.8067117715839, 310.3807903233049, 5350.5184533391985, 5400.243965844785, 5443.265159203511, 5468.9726551367285, 5522.420145884685, 5268.868278293045, 5427.213054107152, 5434.945650543494, 5446.346438427385, 5458.9454105458935, 4133.937990930139, 4191.622753952143, 4195.307774217258, 4203.033302340464, 4207.894802629929, 3963.7225394222414, 4027.7784721840285, 4051.4733084698946, 4165.33354663254, 4185.937210941838, 4117.649999750025, 4147.523034851, 4149.0, 4153.7507749535125, 4171.72883762556, 4154.356074808409, 4155.293600087977, 4156.667466602679, 4160.251154792136, 4163.812628431728, 3627.2745450909924, 3647.379945409287, 3650.3976843820737, 3657.5976642569294, 3659.7804131751914, 5125.359330083739, 5251.396089449724, 5253.159494480865, 5254.3169387979315, 5256.553192978601, 4821.0357928414105, 4829.637777166727, 4833.347498087784, 4834.492378300298, 4835.492273311287, 5707.0583353747, 5710.457506536873, 5712.257406537124, 5713.457221563945, 5719.857003574903, 3776.093737503007, 3866.7679939203736, 3882.650561449483, 4001.4397984282223, 4016.8393264269394, 5989.31122920861, 5997.790077347272, 6004.039353703431, 6005.549583781234, 6011.57918945674, 4090.181963607231, 4119.176164767058, 4119.382092686061, 4121.62905338521, 4127.09203975125, 4184.937225941613, 4189.329707246887, 4192.434021407132, 4194.748315101104, 4196.971741923187, 4633.49031606523, 4766.856994290177, 4771.856844294677, 4777.116233496814, 4794.472608013116, 5690.487856092972, 5691.373948865621, 5701.600887937804, 5702.344230413472, 5706.8871570044275, 1470.6102882736084, 1484.6288427893028, 1486.5317425011303, 1490.3368001239562, 1490.4559835659907, 1004.347174336687, 1007.4257673126394, 1009.8737657792776, 1013.0780989299849, 1028.3264461777549, 5035.974820125876, 5037.420696619935, 5039.143345631252, 5048.192289233705, 5051.848444546669, 5924.496417804448, 5997.070454079625, 5998.25021872266, 5998.25021872266, 6004.369541198199, 5049.82325618609, 5052.747362631927, 5053.84838454847, 5054.039732450822, 5055.292259083732, 3122.141411111917, 3177.539256807796, 3207.294395233045, 3209.791363561361, 3217.8391080445886, 5595.63628364155, 5604.579656525777, 5605.0, 5610.018246806792, 5610.354809196913, 6087.786927457518, 6090.299615544269, 6092.268927728701, 6094.481969032593, 6096.69516524172, 5482.479164479368, 5588.329400471969, 5601.075822489243, 5601.327840659147, 5606.327240731057, 5912.201852749824, 5914.911276330772, 5915.319738229987, 5915.526757859447, 5920.200772895776, 5589.916151257816, 5685.459881311269, 5744.712764361849, 5759.740811663569, 5776.075827867521, 5621.690807005654, 5643.887122257614, 5647.463490968352, 5649.858753531194, 5658.377578466448, 4087.9182416350914, 4090.959090409058, 4115.279826030493, 4118.361653943643, 4119.134981653886, 5850.444207800252, 5934.139549765174, 5942.851428714317, 5960.5827592068135, 5975.073863551156, 5737.426257374396, 5749.942500575108, 5757.0788673811985, 5757.625754325955, 5774.653520788766, 5735.053716136791, 5755.53955683536, 5756.884862302647, 5768.451997060272, 5772.913406298993, 5615.634983726045, 5640.097584386478, 5648.971755141198, 5651.971740141273, 5655.066913959316, 5671.404502527175, 5774.0761478163295, 5788.594798364074, 5799.043157878903, 5802.100674395476, 5650.915236271377, 5651.180578816131, 5655.886882262414, 5658.519025882846, 5667.064934285797], "yui.html": [635.6989970192342, 663.0910780946323, 704.3379223529878, 794.5074054086467, 798.5847359373126, 11923.463444145013, 12173.513059477622, 12223.572174973877, 12254.1422100453, 12257.570985015525, 12542.310172940484, 13263.27052012139, 13264.535741249058, 13266.071375003754, 13272.933635331834, 611.0589691874508, 616.7563812294163, 781.4100354232561, 788.0897563314353, 794.4359504751633, 770.7302444144533, 779.3648176735942, 782.9373650108006, 784.419529548136, 784.8979632647748, 805.5851236613149, 814.1207495904409, 815.3721634341554, 818.0469752738053, 818.2717381530413, 625.6871564217892, 633.0820310549722, 803.8794180872886, 840.7267638017669, 853.0531110467376, 613.3712944232153, 618.3322012226785, 620.8975519039353, 623.0342968398963, 623.0498489803041, 12496.875031249661, 12616.432260548298, 12631.936840315831, 12663.176893501894, 12674.112812103156, 11127.276727012799, 11353.886461135447, 11506.76986460266, 11622.186446948717, 11822.645320640395, 9179.357444978854, 9351.906480935171, 9359.251259899193, 9443.716688499288, 9541.856872146924, 2912.184588315275, 3199.808011519316, 3248.10677063807, 3288.5560449339273, 3299.736021118305, 41937.79031104856, 42344.788276058425, 42408.36387454191, 42612.3608145878, 42714.35928461076, 9442.763930901783, 9479.76300592477, 9525.952370238243, 9528.666496672584, 9587.808243835085, 16940.491785246217, 16975.405860794814, 17094.059826709403, 17103.0, 17126.657466850844, 6118.265808103056, 6204.971315519313, 6473.158489396348, 6540.444062254666, 6635.734570617121, 3559.1280136366754, 3591.6049234584175, 3605.4231322988194, 3625.12996880752, 3658.213484100931, 2775.153578158641, 2781.4715204111153, 2801.9159425217276, 2804.0466241477993, 2810.9297267568472, 411.43633222485386, 415.4619767401223, 430.54147333090157, 432.71873282366715, 432.7511680783499, 485.0759303526787, 488.74340970989806, 507.97206153661165, 527.0302643136647, 546.3498436860124, 8275.684354496654, 8508.149185081442, 8709.956450217709, 8852.778680533038, 8858.468491890508, 497.7038661996107, 504.5811976059862, 508.9770960306795, 571.6884298057569, 585.8798946216016, 3541.3094446583186, 3708.8331025103935, 3743.794091324949, 3921.5490218624655, 3921.941170882439, 47809.0, 48697.0, 48859.511404885496, 48863.51136488661, 48870.51129488731, 44620.55379446164, 44672.0, 44915.775421122686, 45026.77486612546, 45512.544874551495, 40997.180056398705, 41154.1769164621, 41597.1680566387, 41920.37119443211, 41957.79021104875, 7367.300106489874, 7534.962325188339, 7695.422843286888, 7699.641484512383, 7776.144624091458, 30799.692003080578, 30813.22966925755, 31504.0, 31515.84242078775, 32127.839360803046, 36935.815320923226, 37040.444393333586, 37137.81431092935, 40663.39004914869, 40811.79594102011, 6209.316975132641, 6369.267534233622, 6453.903191452226, 6482.448991835558, 6507.902381464187, 9977.145873062433, 10154.644587439405, 10183.0, 10235.590576376862, 10372.896271037192, 9603.519824008912, 9726.416415015121, 9893.35693179941, 9906.950465247628, 10241.283110182216, 9543.143167049753, 9652.324337296603, 9761.0, 9806.705798826046, 9846.064623860722, 9173.633054678005, 9331.113544213289, 9408.95295523518, 9546.379485333431, 9669.0, 8545.188207120314, 8789.736307910773, 8872.86690699627, 8888.511131887808, 8930.106989301017, 8051.355891528547, 8353.791155220924, 8481.321494280319, 8657.480551166951, 8726.0]}, "summary": {"lowerIsBetter": false, "suite": 6262.744621081166, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7494.006337064514, "unit": "ms", "value": 7494.006337064514}, "dojo.html": {"lowerIsBetter": false, "filtered": 4725.442956752747, "unit": "ms", "value": 4725.442956752747}, "mootools.html": {"lowerIsBetter": false, "filtered": 4124.494974397162, "unit": "ms", "value": 4124.494974397162}, "ext.html": {"lowerIsBetter": false, "filtered": 17314.108251569913, "unit": "ms", "value": 17314.108251569913}, "prototype.html": {"lowerIsBetter": false, "filtered": 4292.513143707318, "unit": "ms", "value": 4292.513143707318}, "yui.html": {"lowerIsBetter": false, "filtered": 5557.834720895217, "unit": "ms", "value": 5557.834720895217}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447481293, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team-Non-PGO", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0, 161.0, 160.0], "ai-astar": [111.0, 114.0, 105.0, 110.0, 112.0, 111.0, 98.0, 111.0, 113.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [152.0, 139.0, 163.0, 165.0, 131.0, 155.0, 151.0, 134.0, 171.0, 130.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [137.0, 144.0, 146.0, 143.0, 147.0, 133.0, 150.0, 143.0, 138.0, 138.0], "json-parse-financial": [72.0, 71.0, 72.0, 73.0, 71.0, 71.0, 73.0, 80.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0], "audio-fft": [73.0, 73.0, 79.0, 93.0, 73.0, 74.0, 72.0, 96.0, 92.0, 73.0], "imaging-darkroom": [148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0], "stanford-crypto-ccm": [117.0, 118.0, 119.0, 122.0, 124.0, 119.0, 120.0, 126.0, 124.0, 119.0], "audio-oscillator": [91.0, 92.0, 133.0, 91.0, 91.0, 91.0, 132.0, 90.0, 91.0, 125.0], "stanford-crypto-aes": [85.0, 84.0, 84.0, 84.0, 84.0, 92.0, 83.0, 85.0, 85.0, 84.0], "imaging-desaturate": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1506.9000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.8, "unit": "ms", "value": 79.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.9, "unit": "ms", "value": 141.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.1, "unit": "ms", "value": 149.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.8, "unit": "ms", "value": 120.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.1, "unit": "ms", "value": 72.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.7, "unit": "ms", "value": 102.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.3, "unit": "ms", "value": 160.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.1, "unit": "ms", "value": 95.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447481293, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team-Non-PGO", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.131498470948], "Encrypt": [278.70680044593087], "NavierStokes": [4822.115384615385], "Decrypt": [5020.0], "Splay": [606.6465256797583], "Richards": [163.1055292774425], "RegExp": [26868.42105263158], "Earley": [809.0614886731391], "Boyer": [11788.235294117647], "RayTrace": [1988.0715705765408]}, "summary": {"lowerIsBetter": false, "suite": 19865.306901317897, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.9293760000001, "unit": "score", "value": 345.9293760000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 955.0574279999998, "unit": "score", "value": 955.0574279999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 134.3302838645418, "unit": "score", "value": 134.3302838645418}, "RegExp": {"lowerIsBetter": false, "filtered": 33.90541625857002, "unit": "score", "value": 33.90541625857002}, "Richards": {"lowerIsBetter": false, "filtered": 216.43656200000007, "unit": "score", "value": 216.43656200000007}, "Earley": {"lowerIsBetter": false, "filtered": 823.7482679999999, "unit": "score", "value": 823.7482679999999}, "Boyer": {"lowerIsBetter": false, "filtered": 56.536282435129706, "unit": "score", "value": 56.536282435129706}, "RayTrace": {"lowerIsBetter": false, "filtered": 372.21446699999984, "unit": "score", "value": 372.21446699999984}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447481293, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team-Non-PGO", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}] 22:28:31 INFO - RETURN: dromaeo_css: 6262.74 22:28:31 INFO - RETURN: kraken: 1506.90 22:28:31 INFO - RETURN: v8_7: 19865.31 22:28:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19865.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1506.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6262.74"}}} 22:28:31 INFO - Return code: 0 22:28:31 INFO - # TBPL SUCCESS # 22:28:31 INFO - Running post-action listener: _resource_record_post_action 22:28:31 INFO - Running post-run listener: _resource_record_post_run 22:28:32 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 126976; Write bytes: 513363968; Read time: 564; Write time: 488668 22:28:32 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 143396864; Read time: 0; Write time: 100052 22:28:32 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316751872; Read time: 196; Write time: 264072 22:28:32 INFO - Running post-run listener: _upload_blobber_files 22:28:32 INFO - Blob upload gear active. 22:28:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:28:32 INFO - Copying logs to upload dir... 22:28:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.742373 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-13 22:28:31.892040) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:28:31.895452) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009923 build_url: 'https://queue.taskcluster.net/v1/task/TaVhvKo6QF6_cgVzCkxNFQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:28:31.948267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:28:31.948840) ========= 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=7d909545e45784438f4e8e36000001b3-1447480539.887313-1910838957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004764 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:28:31.999286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:28:31.999653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:28:32.000031) ========= ========= Total master_lag: 0.26 =========