builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1450433004.29 results: success (0) buildid: 20151218011655 builduid: 75aaa4f7f2174d7389eb4ece08dcaf66 revision: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.293075) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.293505) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.293787) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006339 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.366630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.366937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.426355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.426764) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.476125) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.476485) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.476919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.477216) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 02:03:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-12-18 02:03:24 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105273 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.664755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.665094) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022182 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:24.698825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 02:03:24.699229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b32c4163ff05bd0293aa4e1cebc6636aaef60e1c --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 b32c4163ff05bd0293aa4e1cebc6636aaef60e1c --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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 02:03:24,953 truncating revision to first 12 chars 2015-12-18 02:03:24,953 Setting DEBUG logging. 2015-12-18 02:03:24,953 attempt 1/10 2015-12-18 02:03:24,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b32c4163ff05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 02:03:25,726 unpacking tar archive at: fx-team-b32c4163ff05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.130881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 02:03:25.843023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:25.843356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:25.850941) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:25.851266) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 02:03:25.851711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 02:03:25.852007) ========= /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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:03:26 INFO - MultiFileLogger online at 20151218 02:03:26 in /builds/slave/test 02:03:26 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 02:03:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:03:26 INFO - {'append_to_log': False, 02:03:26 INFO - 'base_work_dir': '/builds/slave/test', 02:03:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:03:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:03:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:03:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:03:26 INFO - 'config_files': ('talos/linux_config.py',), 02:03:26 INFO - 'default_actions': ('clobber', 02:03:26 INFO - 'read-buildbot-config', 02:03:26 INFO - 'download-and-extract', 02:03:26 INFO - 'populate-webroot', 02:03:26 INFO - 'create-virtualenv', 02:03:26 INFO - 'install', 02:03:26 INFO - 'run-tests'), 02:03:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:03:26 INFO - 'download_minidump_stackwalk': True, 02:03:26 INFO - 'download_symbols': 'ondemand', 02:03:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:03:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:03:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:03:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:03:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:03:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:03:26 INFO - 'installer_path': 'installer.exe', 02:03:26 INFO - 'log_level': 'info', 02:03:26 INFO - 'log_name': 'talos', 02:03:26 INFO - 'log_to_console': True, 02:03:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:03:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:03:26 INFO - 'opt_config_files': (), 02:03:26 INFO - 'pip_index': False, 02:03:26 INFO - 'sps_profile': False, 02:03:26 INFO - 'sps_profile_interval': 0, 02:03:26 INFO - 'suite': 'dromaeojs', 02:03:26 INFO - 'system_bits': '64', 02:03:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:03:26 INFO - 'title': 'talos-linux64-ix-031', 02:03:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:03:26 INFO - 'use_talos_json': True, 02:03:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:03:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:03:26 INFO - 'work_dir': 'build'} 02:03:26 INFO - ##### 02:03:26 INFO - ##### Running clobber step. 02:03:26 INFO - ##### 02:03:26 INFO - Running pre-action listener: _resource_record_pre_action 02:03:26 INFO - Running main action method: clobber 02:03:26 INFO - rmtree: /builds/slave/test/build 02:03:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:03:26 INFO - Running post-action listener: _resource_record_post_action 02:03:26 INFO - ##### 02:03:26 INFO - ##### Running read-buildbot-config step. 02:03:26 INFO - ##### 02:03:26 INFO - Running pre-action listener: _resource_record_pre_action 02:03:26 INFO - Running main action method: read_buildbot_config 02:03:26 INFO - Using buildbot properties: 02:03:26 INFO - { 02:03:26 INFO - "project": "", 02:03:26 INFO - "product": "firefox", 02:03:26 INFO - "script_repo_revision": "production", 02:03:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:03:26 INFO - "repository": "", 02:03:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:03:26 INFO - "buildid": "20151218011655", 02:03:26 INFO - "pgo_build": "False", 02:03:26 INFO - "basedir": "/builds/slave/test", 02:03:26 INFO - "buildnumber": 2230, 02:03:26 INFO - "slavename": "talos-linux64-ix-031", 02:03:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:03:26 INFO - "platform": "ubuntu64_hw", 02:03:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:03:26 INFO - "branch": "fx-team", 02:03:26 INFO - "repo_path": "integration/fx-team", 02:03:26 INFO - "revision": "b32c4163ff05bd0293aa4e1cebc6636aaef60e1c", 02:03:26 INFO - "stage_platform": "linux64", 02:03:26 INFO - "builduid": "75aaa4f7f2174d7389eb4ece08dcaf66", 02:03:26 INFO - "slavebuilddir": "test" 02:03:26 INFO - } 02:03:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:03:26 INFO - Running post-action listener: _resource_record_post_action 02:03:26 INFO - ##### 02:03:26 INFO - ##### Running download-and-extract step. 02:03:26 INFO - ##### 02:03:26 INFO - Running pre-action listener: _resource_record_pre_action 02:03:26 INFO - Running main action method: download_and_extract 02:03:26 INFO - mkdir: /builds/slave/test/build/tests 02:03:26 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')]} 02:03:26 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json 02:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json 02:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:03:27 INFO - Downloaded 1302 bytes. 02:03:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:03:27 INFO - Using the following test package requirements: 02:03:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:03:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'jsshell-linux-x86_64.zip'], 02:03:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:03:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:03:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:03:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:03:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:03:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:03:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:03:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:27 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:29 INFO - Downloaded 21870957 bytes. 02:03:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:03:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:03:30 INFO - Return code: 0 02:03:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:30 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:32 INFO - Downloaded 21870957 bytes. 02:03:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:03:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:03:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:03:33 INFO - Return code: 0 02:03:33 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')]} 02:03:33 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:03:36 INFO - Downloaded 11132039 bytes. 02:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:03:36 INFO - Return code: 0 02:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:36 INFO - https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:03:38 INFO - Downloaded 53019526 bytes. 02:03:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:38 INFO - mkdir: /builds/slave/test/properties 02:03:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:03:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:03:38 INFO - Contents: 02:03:38 INFO - build_url:https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:03:38 INFO - Running post-action listener: _resource_record_post_action 02:03:38 INFO - Running post-action listener: set_extra_try_arguments 02:03:38 INFO - ##### 02:03:38 INFO - ##### Running populate-webroot step. 02:03:38 INFO - ##### 02:03:38 INFO - Running pre-action listener: _resource_record_pre_action 02:03:38 INFO - Running main action method: populate_webroot 02:03:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:03:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:03:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:03:38 INFO - '--tppagecycles', 02:03:38 INFO - '7'], 02:03:38 INFO - 'tests': ['tsvgm']}}, 02:03:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:03:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:03:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:03:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:03:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'tests': ['damp', 'tps']}, 02:03:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['damp', 'tps']}, 02:03:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:03:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:03:38 INFO - 'other': {'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'other_l64': {'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'other_nol64': {'tests': ['a11yr', 02:03:38 INFO - 'ts_paint', 02:03:38 INFO - 'tpaint', 02:03:38 INFO - 'sessionrestore', 02:03:38 INFO - 'sessionrestore_no_auto_restore']}, 02:03:38 INFO - 'svgr': {'tests': ['tsvgx', 02:03:38 INFO - 'tsvgr_opacity', 02:03:38 INFO - 'tart', 02:03:38 INFO - 'tscrollx', 02:03:38 INFO - 'cart']}, 02:03:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['tsvgx', 02:03:38 INFO - 'tsvgr_opacity', 02:03:38 INFO - 'tart', 02:03:38 INFO - 'tscrollx', 02:03:38 INFO - 'cart']}, 02:03:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'tests': ['tp5o']}, 02:03:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'talos_options': ['--e10s'], 02:03:38 INFO - 'tests': ['tp5o']}, 02:03:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'talos_options': ['--xperf_path', 02:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:38 INFO - 'tests': ['tp5n']}, 02:03:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:38 INFO - 'talos_options': ['--e10s', 02:03:38 INFO - '--xperf_path', 02:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:38 INFO - 'tests': ['tp5n']}}, 02:03:38 INFO - 'talos.zip': {'path': '', 02:03:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:03:38 INFO - Running post-action listener: _resource_record_post_action 02:03:38 INFO - ##### 02:03:38 INFO - ##### Running create-virtualenv step. 02:03:38 INFO - ##### 02:03:38 INFO - Running pre-action listener: _resource_record_pre_action 02:03:38 INFO - Running main action method: create_virtualenv 02:03:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:03:38 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 02:03:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:03:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:03:38 INFO - Using real prefix '/usr' 02:03:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:03:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:03:41 INFO - Installing pip.................done. 02:03:41 INFO - Return code: 0 02:03:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:41 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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:41 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 02:03:41 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 02:03:41 INFO - Using env: {'DISPLAY': ':0', 02:03:41 INFO - 'HOME': '/home/cltbld', 02:03:41 INFO - 'LANG': 'en_US.UTF-8', 02:03:41 INFO - 'LANGUAGE': 'en_US:en', 02:03:41 INFO - 'LOGNAME': 'cltbld', 02:03:41 INFO - 'MAIL': '/var/mail/cltbld', 02:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:41 INFO - 'MOZ_NO_REMOTE': '1', 02:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:41 INFO - 'NO_EM_RESTART': '1', 02:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:41 INFO - 'PWD': '/builds/slave/test', 02:03:41 INFO - 'SHELL': '/bin/bash', 02:03:41 INFO - 'SHLVL': '1', 02:03:41 INFO - 'TERM': 'linux', 02:03:41 INFO - 'TMOUT': '86400', 02:03:41 INFO - 'USER': 'cltbld', 02:03:41 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:41 INFO - '_': '/tools/buildbot/bin/python'} 02:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:41 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 02:03:41 INFO - Cleaning up... 02:03:41 INFO - Return code: 0 02:03:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:41 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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:41 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 02:03:41 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 02:03:41 INFO - Using env: {'DISPLAY': ':0', 02:03:41 INFO - 'HOME': '/home/cltbld', 02:03:41 INFO - 'LANG': 'en_US.UTF-8', 02:03:41 INFO - 'LANGUAGE': 'en_US:en', 02:03:41 INFO - 'LOGNAME': 'cltbld', 02:03:41 INFO - 'MAIL': '/var/mail/cltbld', 02:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:41 INFO - 'MOZ_NO_REMOTE': '1', 02:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:41 INFO - 'NO_EM_RESTART': '1', 02:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:41 INFO - 'PWD': '/builds/slave/test', 02:03:41 INFO - 'SHELL': '/bin/bash', 02:03:41 INFO - 'SHLVL': '1', 02:03:41 INFO - 'TERM': 'linux', 02:03:41 INFO - 'TMOUT': '86400', 02:03:41 INFO - 'USER': 'cltbld', 02:03:41 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:41 INFO - '_': '/tools/buildbot/bin/python'} 02:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:41 INFO - Downloading/unpacking psutil>=0.7.1 02:03:41 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 02:03:41 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 02:03:41 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 02:03:41 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 02:03:41 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 02:03:41 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 02:03:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:03:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:03:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:43 INFO - Installing collected packages: psutil 02:03:43 INFO - Running setup.py install for psutil 02:03:43 INFO - building 'psutil._psutil_linux' extension 02:03:43 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 02:03:43 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 02:03:43 INFO - building 'psutil._psutil_posix' extension 02:03:43 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 02:03:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:03:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:44 INFO - Successfully installed psutil 02:03:44 INFO - Cleaning up... 02:03:44 INFO - Return code: 0 02:03:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:44 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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:44 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 02:03:44 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 02:03:44 INFO - Using env: {'DISPLAY': ':0', 02:03:44 INFO - 'HOME': '/home/cltbld', 02:03:44 INFO - 'LANG': 'en_US.UTF-8', 02:03:44 INFO - 'LANGUAGE': 'en_US:en', 02:03:44 INFO - 'LOGNAME': 'cltbld', 02:03:44 INFO - 'MAIL': '/var/mail/cltbld', 02:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:44 INFO - 'MOZ_NO_REMOTE': '1', 02:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:44 INFO - 'NO_EM_RESTART': '1', 02:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:44 INFO - 'PWD': '/builds/slave/test', 02:03:44 INFO - 'SHELL': '/bin/bash', 02:03:44 INFO - 'SHLVL': '1', 02:03:44 INFO - 'TERM': 'linux', 02:03:44 INFO - 'TMOUT': '86400', 02:03:44 INFO - 'USER': 'cltbld', 02:03:44 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:44 INFO - '_': '/tools/buildbot/bin/python'} 02:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:03:44 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 02:03:44 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 02:03:44 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 02:03:44 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 02:03:44 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 02:03:44 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 02:03:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:03:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:03:46 INFO - Installing collected packages: mozsystemmonitor 02:03:46 INFO - Running setup.py install for mozsystemmonitor 02:03:46 INFO - Successfully installed mozsystemmonitor 02:03:46 INFO - Cleaning up... 02:03:46 INFO - Return code: 0 02:03:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:03: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')]} 02:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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')]} 02:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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', '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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:03: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 blobuploader==1.2.4 02:03:46 INFO - Using env: {'DISPLAY': ':0', 02:03:46 INFO - 'HOME': '/home/cltbld', 02:03:46 INFO - 'LANG': 'en_US.UTF-8', 02:03:46 INFO - 'LANGUAGE': 'en_US:en', 02:03:46 INFO - 'LOGNAME': 'cltbld', 02:03:46 INFO - 'MAIL': '/var/mail/cltbld', 02:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:46 INFO - 'MOZ_NO_REMOTE': '1', 02:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:46 INFO - 'NO_EM_RESTART': '1', 02:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:46 INFO - 'PWD': '/builds/slave/test', 02:03:46 INFO - 'SHELL': '/bin/bash', 02:03:46 INFO - 'SHLVL': '1', 02:03:46 INFO - 'TERM': 'linux', 02:03:46 INFO - 'TMOUT': '86400', 02:03:46 INFO - 'USER': 'cltbld', 02:03:46 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:46 INFO - '_': '/tools/buildbot/bin/python'} 02:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:03:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:03:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03:48 INFO - Downloading docopt-0.6.1.tar.gz 02:03:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:03:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:03:48 INFO - Running setup.py install for blobuploader 02:03:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:03:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:03:48 INFO - Running setup.py install for requests 02:03:49 INFO - Running setup.py install for docopt 02:03:49 INFO - Successfully installed blobuploader requests docopt 02:03:49 INFO - Cleaning up... 02:03:49 INFO - Return code: 0 02:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:49 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')]} 02:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:49 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')]} 02:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:49 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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:49 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 02:03:49 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 02:03:49 INFO - Using env: {'DISPLAY': ':0', 02:03:49 INFO - 'HOME': '/home/cltbld', 02:03:49 INFO - 'LANG': 'en_US.UTF-8', 02:03:49 INFO - 'LANGUAGE': 'en_US:en', 02:03:49 INFO - 'LOGNAME': 'cltbld', 02:03:49 INFO - 'MAIL': '/var/mail/cltbld', 02:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:49 INFO - 'MOZ_NO_REMOTE': '1', 02:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:49 INFO - 'NO_EM_RESTART': '1', 02:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:49 INFO - 'PWD': '/builds/slave/test', 02:03:49 INFO - 'SHELL': '/bin/bash', 02:03:49 INFO - 'SHLVL': '1', 02:03:49 INFO - 'TERM': 'linux', 02:03:49 INFO - 'TMOUT': '86400', 02:03:49 INFO - 'USER': 'cltbld', 02:03:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:49 INFO - '_': '/tools/buildbot/bin/python'} 02:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:49 INFO - Running setup.py (path:/tmp/pip-TQdlaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:49 INFO - Running setup.py (path:/tmp/pip-THuYuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:49 INFO - Running setup.py (path:/tmp/pip-ib8ViF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:49 INFO - Running setup.py (path:/tmp/pip-KuEact-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:49 INFO - Running setup.py (path:/tmp/pip-BgVLXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:49 INFO - Running setup.py (path:/tmp/pip-GR7ybM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:50 INFO - Running setup.py (path:/tmp/pip-si6M0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:50 INFO - Running setup.py (path:/tmp/pip-9ATPql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:50 INFO - Running setup.py (path:/tmp/pip-xIcVIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:50 INFO - Running setup.py (path:/tmp/pip-rJB0_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:50 INFO - Running setup.py (path:/tmp/pip-MXwCyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:50 INFO - Running setup.py (path:/tmp/pip-YXKHRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:50 INFO - Running setup.py (path:/tmp/pip-urvcmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:50 INFO - Running setup.py (path:/tmp/pip-cpI5qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:50 INFO - Running setup.py (path:/tmp/pip-BoyQKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:50 INFO - Running setup.py (path:/tmp/pip-BTpscB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:50 INFO - Running setup.py (path:/tmp/pip-PmG1HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:03:50 INFO - Running setup.py install for manifestparser 02:03:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:03:50 INFO - Running setup.py install for mozcrash 02:03:51 INFO - Running setup.py install for mozdebug 02:03:51 INFO - Running setup.py install for mozdevice 02:03:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for mozfile 02:03:51 INFO - Running setup.py install for mozhttpd 02:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for mozinfo 02:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for mozInstall 02:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for mozleak 02:03:51 INFO - Running setup.py install for mozlog 02:03:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for moznetwork 02:03:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:03:51 INFO - Running setup.py install for mozprocess 02:03:52 INFO - Running setup.py install for mozprofile 02:03:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:03:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:03:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:03:52 INFO - Running setup.py install for mozrunner 02:03:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:03:52 INFO - Running setup.py install for mozscreenshot 02:03:52 INFO - Running setup.py install for moztest 02:03:52 INFO - Running setup.py install for mozversion 02:03:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:03:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:03:52 INFO - Cleaning up... 02:03:52 INFO - Return code: 0 02:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:52 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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:52 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 02:03:52 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 02:03:52 INFO - Using env: {'DISPLAY': ':0', 02:03:52 INFO - 'HOME': '/home/cltbld', 02:03:52 INFO - 'LANG': 'en_US.UTF-8', 02:03:52 INFO - 'LANGUAGE': 'en_US:en', 02:03:52 INFO - 'LOGNAME': 'cltbld', 02:03:52 INFO - 'MAIL': '/var/mail/cltbld', 02:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:52 INFO - 'MOZ_NO_REMOTE': '1', 02:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:52 INFO - 'NO_EM_RESTART': '1', 02:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:52 INFO - 'PWD': '/builds/slave/test', 02:03:52 INFO - 'SHELL': '/bin/bash', 02:03:52 INFO - 'SHLVL': '1', 02:03:52 INFO - 'TERM': 'linux', 02:03:52 INFO - 'TMOUT': '86400', 02:03:52 INFO - 'USER': 'cltbld', 02:03:52 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:52 INFO - '_': '/tools/buildbot/bin/python'} 02:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:52 INFO - Running setup.py (path:/tmp/pip-WxvVnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:52 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)) 02:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:52 INFO - Running setup.py (path:/tmp/pip-cCCe4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:53 INFO - Running setup.py (path:/tmp/pip-umDOO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:53 INFO - Running setup.py (path:/tmp/pip-x_FTo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:53 INFO - Running setup.py (path:/tmp/pip-huxkcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:53 INFO - Running setup.py (path:/tmp/pip-o78d2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:53 INFO - Running setup.py (path:/tmp/pip-CRv951-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:53 INFO - Running setup.py (path:/tmp/pip-hlDQjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:53 INFO - Running setup.py (path:/tmp/pip-YrGehY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:53 INFO - Running setup.py (path:/tmp/pip-wjZIbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:53 INFO - Running setup.py (path:/tmp/pip-xbtQAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:53 INFO - Running setup.py (path:/tmp/pip-dEJsYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:53 INFO - Running setup.py (path:/tmp/pip-XWpjre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:53 INFO - Running setup.py (path:/tmp/pip-GTT3ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:53 INFO - Running setup.py (path:/tmp/pip-3Pu_Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:53 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)) 02:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:53 INFO - Running setup.py (path:/tmp/pip-yOD69f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:54 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)) 02:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:54 INFO - Running setup.py (path:/tmp/pip-GALD_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:54 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)) 02:03:54 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)) 02:03:54 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)) 02:03:54 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)) 02:03:54 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)) 02:03:54 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)) 02:03:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:55 INFO - Downloading blessings-1.5.1.tar.gz 02:03:55 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 02:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:03:56 INFO - Installing collected packages: blessings 02:03:56 INFO - Running setup.py install for blessings 02:03:56 INFO - Successfully installed blessings 02:03:56 INFO - Cleaning up... 02:03:56 INFO - Return code: 0 02:03:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:56 INFO - Reading from file tmpfile_stdout 02:03:56 INFO - Current package versions: 02:03:56 INFO - argparse == 1.2.1 02:03:56 INFO - blessings == 1.5.1 02:03:56 INFO - blobuploader == 1.2.4 02:03:56 INFO - docopt == 0.6.1 02:03:56 INFO - manifestparser == 1.1 02:03:56 INFO - mozInstall == 1.12 02:03:56 INFO - mozcrash == 0.16 02:03:56 INFO - mozdebug == 0.1 02:03:56 INFO - mozdevice == 0.47 02:03:56 INFO - mozfile == 1.2 02:03:56 INFO - mozhttpd == 0.7 02:03:56 INFO - mozinfo == 0.9 02:03:56 INFO - mozleak == 0.1 02:03:56 INFO - mozlog == 3.1 02:03:56 INFO - moznetwork == 0.27 02:03:56 INFO - mozprocess == 0.22 02:03:56 INFO - mozprofile == 0.27 02:03:56 INFO - mozrunner == 6.11 02:03:56 INFO - mozscreenshot == 0.1 02:03:56 INFO - mozsystemmonitor == 0.0 02:03:56 INFO - moztest == 0.7 02:03:56 INFO - mozversion == 1.4 02:03:56 INFO - psutil == 3.1.1 02:03:56 INFO - requests == 1.2.3 02:03:56 INFO - wsgiref == 0.1.2 02:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:56 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 02:03:56 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 02:03:56 INFO - Using env: {'DISPLAY': ':0', 02:03:56 INFO - 'HOME': '/home/cltbld', 02:03:56 INFO - 'LANG': 'en_US.UTF-8', 02:03:56 INFO - 'LANGUAGE': 'en_US:en', 02:03:56 INFO - 'LOGNAME': 'cltbld', 02:03:56 INFO - 'MAIL': '/var/mail/cltbld', 02:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:56 INFO - 'MOZ_NO_REMOTE': '1', 02:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:56 INFO - 'NO_EM_RESTART': '1', 02:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:56 INFO - 'PWD': '/builds/slave/test', 02:03:56 INFO - 'SHELL': '/bin/bash', 02:03:56 INFO - 'SHLVL': '1', 02:03:56 INFO - 'TERM': 'linux', 02:03:56 INFO - 'TMOUT': '86400', 02:03:56 INFO - 'USER': 'cltbld', 02:03:56 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:56 INFO - '_': '/tools/buildbot/bin/python'} 02:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03:56 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)) 02:03: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:03:56 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)) 02:03:56 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)) 02:03:56 INFO - Cleaning up... 02:03:56 INFO - Return code: 0 02:03:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:03:56 INFO - Using env: {'DISPLAY': ':0', 02:03:56 INFO - 'HOME': '/home/cltbld', 02:03:56 INFO - 'LANG': 'en_US.UTF-8', 02:03:56 INFO - 'LANGUAGE': 'en_US:en', 02:03:56 INFO - 'LOGNAME': 'cltbld', 02:03:56 INFO - 'MAIL': '/var/mail/cltbld', 02:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:56 INFO - 'MOZ_NO_REMOTE': '1', 02:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:56 INFO - 'NO_EM_RESTART': '1', 02:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:56 INFO - 'PWD': '/builds/slave/test', 02:03:56 INFO - 'SHELL': '/bin/bash', 02:03:56 INFO - 'SHLVL': '1', 02:03:56 INFO - 'TERM': 'linux', 02:03:56 INFO - 'TMOUT': '86400', 02:03:56 INFO - 'USER': 'cltbld', 02:03:56 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:56 INFO - '_': '/tools/buildbot/bin/python'} 02:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:56 INFO - Downloading/unpacking jsonschema 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03: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 02:03:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:03:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:03:58 INFO - Downloading/unpacking functools32 (from jsonschema) 02:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:03:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:03:58 INFO - warning: no files found matching '*.txt' 02:03:58 INFO - no previously-included directories found matching 'build' 02:03:58 INFO - no previously-included directories found matching 'dist' 02:03:58 INFO - no previously-included directories found matching '.git*' 02:03:58 INFO - Installing collected packages: jsonschema, functools32 02:03:58 INFO - Running setup.py install for functools32 02:03:58 INFO - warning: no files found matching '*.txt' 02:03:58 INFO - no previously-included directories found matching 'build' 02:03:58 INFO - no previously-included directories found matching 'dist' 02:03:58 INFO - no previously-included directories found matching '.git*' 02:03:58 INFO - Successfully installed jsonschema functools32 02:03:58 INFO - Cleaning up... 02:03:58 INFO - Return code: 0 02:03:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:03: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')]} 02:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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')]} 02:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7059b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', '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 02:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:03:59 INFO - Using env: {'DISPLAY': ':0', 02:03:59 INFO - 'HOME': '/home/cltbld', 02:03:59 INFO - 'LANG': 'en_US.UTF-8', 02:03:59 INFO - 'LANGUAGE': 'en_US:en', 02:03:59 INFO - 'LOGNAME': 'cltbld', 02:03:59 INFO - 'MAIL': '/var/mail/cltbld', 02:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:59 INFO - 'MOZ_NO_REMOTE': '1', 02:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:59 INFO - 'NO_EM_RESTART': '1', 02:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:59 INFO - 'PWD': '/builds/slave/test', 02:03:59 INFO - 'SHELL': '/bin/bash', 02:03:59 INFO - 'SHLVL': '1', 02:03:59 INFO - 'TERM': 'linux', 02:03:59 INFO - 'TMOUT': '86400', 02:03:59 INFO - 'USER': 'cltbld', 02:03:59 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:59 INFO - '_': '/tools/buildbot/bin/python'} 02:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:59 INFO - Downloading/unpacking flake8 02:03:59 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 02:03:59 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 02:03:59 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 02:03:59 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 02:03:59 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 02:03:59 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 02:04:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:04:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:04:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:04:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:04:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:01 INFO - no previously-included directories found matching 'docs/_build' 02:04:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:04:01 INFO - Running setup.py install for pep8 02:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:01 INFO - no previously-included directories found matching 'docs/_build' 02:04:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:04:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:04:01 INFO - Cleaning up... 02:04:01 INFO - Return code: 0 02:04:01 INFO - Running post-action listener: _resource_record_post_action 02:04:01 INFO - Running post-action listener: _start_resource_monitoring 02:04:01 INFO - Starting resource monitoring. 02:04:01 INFO - ##### 02:04:01 INFO - ##### Running install step. 02:04:01 INFO - ##### 02:04:01 INFO - Running pre-action listener: _resource_record_pre_action 02:04:01 INFO - Running main action method: install 02:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:02 INFO - Reading from file tmpfile_stdout 02:04:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:04:02 INFO - Reading from file tmpfile_stdout 02:04:02 INFO - Output received: 02:04:02 INFO - Usage: mozinstall [options] installer 02:04:02 INFO - Options: 02:04:02 INFO - -h, --help show this help message and exit 02:04:02 INFO - -d DEST, --destination=DEST 02:04:02 INFO - Directory to install application into. [default: 02:04:02 INFO - "/builds/slave/test"] 02:04:02 INFO - --app=APP Application being installed. [default: firefox] 02:04:02 INFO - mkdir: /builds/slave/test/build/application 02:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:04:17 INFO - Reading from file tmpfile_stdout 02:04:17 INFO - Output received: 02:04:17 INFO - /builds/slave/test/build/application/firefox/firefox 02:04:17 INFO - Running post-action listener: _resource_record_post_action 02:04:17 INFO - ##### 02:04:17 INFO - ##### Running run-tests step. 02:04:17 INFO - ##### 02:04:17 INFO - Running pre-action listener: _resource_record_pre_action 02:04:17 INFO - Running main action method: run_tests 02:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:04:17 INFO - Python 2.7.3 02:04:17 INFO - Return code: 0 02:04:17 INFO - grabbing minidump binary from tooltool 02:04:17 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')]} 02:04:17 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 0x22960b0>, '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 0x2296fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2297440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:04:17 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 02:04:17 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 02:04:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:04:17 INFO - Return code: 0 02:04:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:04:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:04:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:04:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:04:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:04:18 INFO - Return code: 0 02:04:18 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/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test/build 02:04:18 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/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 02:04:18 INFO - Using env: {'DISPLAY': ':0', 02:04:18 INFO - 'HOME': '/home/cltbld', 02:04:18 INFO - 'LANG': 'en_US.UTF-8', 02:04:18 INFO - 'LANGUAGE': 'en_US:en', 02:04:18 INFO - 'LOGNAME': 'cltbld', 02:04:18 INFO - 'MAIL': '/var/mail/cltbld', 02:04:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:04:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:18 INFO - 'MOZ_NO_REMOTE': '1', 02:04:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:18 INFO - 'NO_EM_RESTART': '1', 02:04:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:18 INFO - 'PWD': '/builds/slave/test', 02:04:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:04:18 INFO - 'SHELL': '/bin/bash', 02:04:18 INFO - 'SHLVL': '1', 02:04:18 INFO - 'TERM': 'linux', 02:04:18 INFO - 'TMOUT': '86400', 02:04:18 INFO - 'USER': 'cltbld', 02:04:18 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475', 02:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:18 INFO - '_': '/tools/buildbot/bin/python'} 02:04:18 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/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 02:04:18 INFO - mozversion INFO | application_buildid: 20151218011655 02:04:18 INFO - mozversion INFO | application_changeset: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c 02:04:18 INFO - mozversion INFO | application_display_name: Nightly 02:04:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:04:18 INFO - mozversion INFO | application_name: Firefox 02:04:18 INFO - mozversion INFO | application_remotingname: firefox 02:04:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:04:18 INFO - mozversion INFO | application_vendor: Mozilla 02:04:18 INFO - mozversion INFO | application_version: 46.0a1 02:04:18 INFO - mozversion INFO | platform_buildid: 20151218011655 02:04:18 INFO - mozversion INFO | platform_changeset: b32c4163ff05bd0293aa4e1cebc6636aaef60e1c 02:04:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:04:18 INFO - mozversion INFO | platform_version: 46.0a1 02:04:18 INFO - 2015-12-18 02:04:18,724 DEBUG : using testdate: 1450433058 02:04:18 INFO - 2015-12-18 02:04:18,724 DEBUG : actual date: 1450433058 02:04:18 INFO - 2015-12-18 02:04:18,733 INFO : starting webserver on 'localhost:54142' 02:04:18 INFO - 2015-12-18 02:04:18,734 INFO : Starting test suite talos-linux64-ix-031 02:04:18 INFO - 2015-12-18 02:04:18,734 INFO : Starting test dromaeo_css 02:04:18 INFO - 2015-12-18 02:04:18,734 DEBUG : operating with platform_type : linux_ 02:04:18 INFO - 2015-12-18 02:04:18,735 INFO : Initialising browser for dromaeo_css test... 02:04:18 INFO - 2015-12-18 02:04:18,752 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmnV6_/profile http://localhost:54142/getInfo.html 02:04:23 INFO - 2015-12-18 02:04:23,210 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:04:23 INFO - 2015-12-18 02:04:23,210 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:04:23 INFO - 2015-12-18 02:04:23,210 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:04:23 INFO - 2015-12-18 02:04:23,210 DEBUG : BROWSER_OUTPUT: __metrics 02:04:23 INFO - 2015-12-18 02:04:23,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:04:23 INFO - 2015-12-18 02:04:23,331 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:04:24 INFO - 2015-12-18 02:04:24,222 INFO : Browser initialized. 02:04:24 INFO - 2015-12-18 02:04:24,222 INFO : Running cycle 1/1 for dromaeo_css test... 02:04:24 INFO - 2015-12-18 02:04:24,222 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmnV6_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:04:36 INFO - 2015-12-18 02:04:36,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 149630976 02:04:36 INFO - 2015-12-18 02:04:36,216 DEBUG : BROWSER_OUTPUT: 02:05:27 INFO - 2015-12-18 02:05:27,793 DEBUG : BROWSER_OUTPUT: 1450433127793 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] 02:07:39 INFO - 2015-12-18 02:07:39,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54142/tests/dromaeo/cssquery-ext.html) 02:07:40 INFO - 2015-12-18 02:07:40,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 246370304 02:07:40 INFO - 2015-12-18 02:07:40,961 DEBUG : BROWSER_OUTPUT: 02:10:43 INFO - 2015-12-18 02:10:43,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-ext.html (next: http://localhost:54142/tests/dromaeo/cssquery-jquery.html) 02:10:44 INFO - 2015-12-18 02:10:44,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 224931840 02:10:44 INFO - 2015-12-18 02:10:44,012 DEBUG : BROWSER_OUTPUT: 02:13:46 INFO - 2015-12-18 02:13:46,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54142/tests/dromaeo/cssquery-mootools.html) 02:13:46 INFO - 2015-12-18 02:13:46,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 225898496 02:13:46 INFO - 2015-12-18 02:13:46,696 DEBUG : BROWSER_OUTPUT: 02:16:48 INFO - 2015-12-18 02:16:48,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54142/tests/dromaeo/cssquery-prototype.html) 02:16:49 INFO - 2015-12-18 02:16:49,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 212815872 02:16:49 INFO - 2015-12-18 02:16:49,285 DEBUG : BROWSER_OUTPUT: 02:19:51 INFO - 2015-12-18 02:19:51,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54142/tests/dromaeo/cssquery-yui.html) 02:19:52 INFO - 2015-12-18 02:19:52,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 191905792 02:19:52 INFO - 2015-12-18 02:19:52,512 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/dromaeo/cssquery-yui.html (next: http://localhost:54142/tests/dromaeo/cssquery-dojo.html) 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 264839168 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:22:55 INFO - 2015-12-18 02:22:55,325 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:22:55 INFO - 2015-12-18 02:22:55,327 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2602.4534847681985;2692.448048150127;2693.2593536777385;2700.743429374209;2720.088770261962;4470.664700147486;4635.582797548228;4644.047970166116;4657.580817726404;4661.277501987193;4548.454185497737;4595.839145629903;4691.601213896823;4696.64775141864;4714.528547145293;4305.4833419989645;4352.956470435302;4355.412019377375;4379.978100109495;4399.472063352402;4381.255186618267;4416.536263692315;4438.600525952664;4450.866474005785;4486.192485352635;4152.1280531088505;4231.555686652888;4269.466316710411;4284.228838809013;4331.436913201295;4344.45694288214;4347.413099231595;4362.411074504965;4364.236258654754;4389.495208051083;4323.589259020388;4324.783760811947;4332.133573285356;4339.47926248849;4368.213721530124;4455.108978204372;4540.455145382575;4578.473475550288;4590.288505281686;4663.282267846719;5058.671186372874;5079.949200507985;5082.79668813247;5083.79664813407;5108.66793658411;5083.61872859537;5083.720395378253;5085.923711144335;5088.745562721886;5140.126178549655;4512.029913568598;4626.05165940988;4713.34013238147;4715.552022557851;4717.150912835654;5042.747862606855;5056.089903817275;5105.8723531912;5161.74191290434;5167.612429067835;4951.034548263054;4954.033963377179;4962.230854217602;4962.5533701967;5002.024605201951;4878.780454879539;5030.899382012412;5045.899082018339;5050.924236136461;5058.620603454756;4818.060478206786;4883.194272944925;4899.779509922062;4931.778069986859;4956.107900577858;4970.676906001171;4986.8753281168265;4990.8752281193265;4996.525330093636;4997.600191984632;4213.241616509058;4222.915541689149;4230.471191101113;4258.701890867609;4262.42457268271;3556.6798988090677;3650.9817450912574;3677.3932301170544;3679.9816000919823;3706.129059670975;4320.827166913351;4355.499117601453;4381.40850985113;4384.846530371422;4425.822967081345;5078.873028174326;5100.1074811907765;5100.51545103222;5112.36095488064;5146;4152.792360381969;4237;4244.915101697949;4246.341817018367;4351.6518678505645;4457.3091170868565;4458.5318541553315;4465.062336909221;4467.821287148543;4486.6186374157905;4769.451513075971;4788.688735232199;4795.376601041842;4802.447718512346;4843;4827.468978412442;4956.182229932021;4957.900841983068;4968.726720030433;5055.064813009458;4781.52184781533;4784.880377990439;4795.760211989317;4796.856094317176;4832.63755218353;4944.1100601892;4958.504149585013;4961.05739909416;4963.503649635008;5007.29897814299;4799.448063472745;4893.290472881484;4937.456879743154;4939.703617782944;5039.84880453587;4881.194602890483;4924.433690125538;4957.702537847741;4960.107180707508;4963.280324353021;4940.036692844861;4943.8516844494725;4944.184209605375;4952.009598080471;4968.155413579628;4640.814367425265;4718.103560323528;4732.958749075198;4745.715257084448;4890.437599676083;4879.926801098058;4890.437599676083;4905.8037678492465;4909.5090490950615;4911.8280860169725;4801.039792041675;4801.5438533339275;4802.73584952817;4806.7836947336755;4834.564889159992 02:22:55 INFO - 2015-12-18 02:22:55,328 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.8648844544641;540.9594280428969;541.88078622703;568.3435631845217;577.8382053025155;27208;27697.446051079016;27728.30679233015;27742.583861242074;27769;27847.721522784766;35993.2801343973;36199;36244.275114497694;36249.27501449976;7833.882491762613;7966.203379662045;7969.2030796920135;7969.282764551218;7977.960110199441;7176.748813791518;7370.889436658427;7945.245201705858;8046.919530804705;8077.7576672699915;7216.530925489827;10404.791904161912;10640.361578305288;10650.094741946943;10658.200634952409;10225.130863876579;10344.948275258575;10353.068223859813;10358.067773900348;10358.378497290187;7042;7208;7208.675609597581;9989.65036223736;10160.288779785418;25549.48901021969;26041.348966275804;41320.586794131974;42362.15275694469;42384.36423453651;2768.0319640602975;2874.238326843388;3037.772167087477;3409.454487282048;3599.712023038177;26737.19788406351;26992.59511107335;27368.178954631192;27389.86305068462;27581.58627620587;3458.654134586546;3492.9126771830906;3506.8947931562093;3513.8243087845763;3631.7457777955556;175100;175478.99999999872;175728;175944;176556;51863.481365185864;53092.46907530953;53135.46864531383;53180.73409632927;55228.723856380464;55193.44806551963;55252;55301;55477.445225548036;55584.16623750647;13360.732785344433;13559.728805424034;13638.931805341108;13680.452781888613;13687.178769273876;9385.202257808163;9505.334626576212;9511.953685094633;9551.856722149174;9596.856047159297;19300.517487062934;19309.710354344697;19437;19453.513662158275;19506.609867802563;6899.550224887556;7261.128664560287;7277.963610181915;7300.379467745302;7319.52423092508;861.5606040919176;877.7059685005595;882.8875616722847;961.3222678011984;1050.2963014780116;27036.459270814474;27122.101452898107;27332.316692082855;27623.585646215324;27630.585541216897;989.2778271861581;1013.2856336282903;1048.1457612046158;1068.3483075324045;1074.9193810464246;14119;14135.293235338399;14234;14358.210298433478;14369.281535923372;273025;279076;279094;279165;279495;47639.52360476351;47994.28008579874;48029;48138.5186148134;48145;1200.8138738495547;1209.0810983652486;1214.3848681253912;1233.7285797124798;1234.851817781872;25398.873005634854;26339.73660263373;26715.19854404371;27075.59386609242;27170.456590868467;41292.79353603213;41747.165056699305;41755;41818.58181418147;41829.37255941102;304947;309538;336434;344300;345618;26649.200523984313;26953.595696064967;26954.865225673748;26994.190174294803;27004.45991080128;36525.45211821772;38227.235455291295;39163.804180978914;39656.206875862896;40355.394669080575;29527.26181845385;29641.110766677033;29686.406271874872;32481;34304;30838.53742193824;32168.404250012285;32644.183895401853;32683.50974735333;32716.509252360756;31982;32256.677433226305;32282.515762264055;32417;32431.675683242865;28314.150575482767;29916;32952.835235823666;33286.334273313914;33645.66354336523;23293.534129317657;23628.645570316115;23867.761322386556;25151.530182034185;25421.491570168862 02:22:55 INFO - 2015-12-18 02:22:55,331 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.81647868954025;327.26244960902045;334.6636630186663;334.8744220917155;337.0394376028319;12554.560590379338;12982.54561090362;14666.193359365245;15273.389064437422;16009.999999999985;9800.460974646392;10817.83773243402;11825.29048257103;15914.920425397857;15931;4495.57292057254;4550.499445061049;4653.930191047137;4671.6262698984;4674.836380726675;3472.3576138414346;3574.124339536804;4611.631069514431;5029.723365214912;5189.688618682872;5186.040582492251;5188.8702782430555;5203.375594928595;5208.322918020652;5212.687238765668;5059.873503162414;5174.35320584925;5219.164933610642;5241.24002019705;5257.5005374489365;5066.620003499752;5067.163917953533;5075.162598171298;5078.390593128811;5079.060373830853;11941.223820451643;17679.5580110497;18252.90873545637;19582.51043723904;19602.50993725154;1864.3102052240622;1876.6340563590106;1877.0520886952138;1914.9521261968562;2005.548751530894;8498.447600905922;8659.783505412352;8696.739097827012;8814.382993190478;9425.010373910778;1734.332282071399;1891.092275707668;1901.115981068796;1908.2748555548942;1949.4931317857458;51356.74321628443;54901.45098549003;56600.71699641517;57309;57430.138547921815;9252.722418327461;9466.148046675833;9538.046195380546;9722.854157187649;9809.117179453884;12394.81407778884;12407.069469789622;12413.627591172279;12413.813792793115;12419.93790031044;6673.566218195801;6706.362895524917;6715.294894036154;6731.798046058528;6736.831579210559;6304.873902522016;6325.335839736854;6349.777757778548;6362.491000719931;6380.968095159587;4090.2637525245145;4143.129942712004;4164;4164.7709375984;4191.7275377101005;1602.7675986981822;1669.6577201673629;1697.6434948660672;1706.7951845778587;1765.885217460861;807.7334479621711;857.2756021162108;964.8697425847421;991.6231831903831;1009.1976878381557;15131;15649.765253521206;15801.683966320608;16112.516624501284;16131.274092665859;776.2198990014999;841.9073901870789;848.1427657389947;876.6712482818942;882.9293656507464;8496.575171241413;8716.520591367536;8753.518556479456;8782.429142105742;8862.86705699415;301452;308055;429594;433419;433876;62013.689931550056;62235;67513;74732;76821;984.5667906121283;997.1872923567414;1001.6143784642819;1021.4892553723139;1022.2792930983638;14582.30253131977;14601.488947886774;14715.55853324402;14795.482158124414;14938.402463901322;31905.202369940936;31934.68065319317;32689.673103268662;33242.50136248006;33314;41755.58244417517;43004.56995430131;43968.82296181858;44280.335794962455;47125.05749885052;8838.690645827364;8925.419847709878;9047.638094476411;9137.08629137081;9145.131212534798;15609.609759755642;15861.286242118902;16013.8398616017;16106.67786644284;16350.918245408697;13169.209847409185;13366;13752.518661846787;13774;13921.443142274196;13082.803757943448;13141.605751827461;13444.932775336061;13596.252206128758;13688.384022719201;11077.667669969915;11329.660110196708;13385.397657105259;13434.261115638343;14120.50578229757;8414.074451810418;8478.23695867375;8625.784355391166;8711.172438618321;8816.074312197126;8862.911370886466;8871.423357481743;8897.866532001895;8920.375573709778;9004.144606262395 02:22:55 INFO - 2015-12-18 02:22:55,333 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1251.5807204586463;1368.9178649281043;1391.9977616116394;1625.707372672919;1704.4460550321144;6080.543959203061;6971.721131154754;7150.606716630583;7165.426765858731;7178;7164.140303163615;7197.640117994092;7239.6380180991;7245.456590755688;7260.96369518153;1734.80917099119;1769.7699299091164;2047.37555045711;2088.95822083559;2092.696558998944;2044.1721102953327;2086.3636590839787;2089.1643342662906;2089.1956596710224;2091.9581608367826;1999.2302963359139;2002.979970200294;2006.0671787618755;2006.9598608027832;2053.7638171610233;2031.7054027166052;2052.7331446911808;2063.1850419084376;2063.752349718036;2065.060397519125;2014.8186663200236;2072.1504183284933;2075.802798734118;2077.0237988145545;2077.6779599162155;6936.132983377078;6994.930050699479;7004.929950700479;7018.649067546602;7029.121359830021;4037.1723796621623;4117.135401565675;4117.876463706094;4118.691098167619;4120.587941205886;2563.128536297668;2576.8196226264167;2674.505216534928;2684.315499547603;2684.8389096654264;846.1622993236651;857.438377862501;884.3986089459165;899.9965038981554;900.7703035725848;9424.96325404205;9429.669961551313;9436.905630943671;9443.291753118476;9445.102715242041;3659.853605855736;3739.8130093495215;3761.39817629178;3765.134019175605;3791.4123310886857;8158.714444994397;8159.592020398956;8162.877556836652;8165.101838797727;8166.632501537445;4121.278776214211;4138.193052354822;4140.254754144223;4150.937735933963;4152.148809494107;3748.2878253131817;3756.229972855558;3758.0792705787258;3760.3231418344963;3762.6237376262156;2946.071987324029;3059.434004709136;3322.8172450515453;3442.4836274559016;3445.8277086145595;1050.6060227414719;1105.4307031878589;1109.9056580190613;1110.9833352499718;1114.3703807348984;896.4845214001975;896.852019416802;901.6528636475005;903.8418276801533;1197.1500234833366;6673.165854268216;6731.562448440934;6733.562318449285;6741.460683145337;6752.561083529653;1019.403648865422;1024.4365598920565;1028.095276156977;1034.4982683398546;1051.64244156987;5252.527272545412;5289.18017707256;5291.841244762663;5301.867453313621;5310.946890531122;8112.391570632226;8647.783805404915;8656.6537338507;8663.26362259215;8664.8700269496;8517.06312305646;8520.318374530023;8527.104654011364;8542.786430339167;8569.271611913056;6503.447206987459;6646.368594983469;6746.325367463312;6753.864922701617;6781.25406205317;6403.263624683221;6423.678816059085;6438.967805160944;6441.194850643669;6441.259255185526;7474.215207403145;7712.730054448068;7724.343430808444;7731.806704832424;7732.497387669783;7321.487495875238;7350.7427240046345;7456.888146677696;7459.589722565311;7841.803954901173;6043.335233124265;6057.939420605738;6096.8780624388155;6132.601380910227;6150.907736383869;5887.558433117448;6245.313015568193;6422.133012043314;7016.438684905297;7073.045138906387;6414.903776443264;6477.514186435942;6533.771318003847;6568.047633093079;6581.407673309425;6162.7534898605345;6314.052892066226;6328.24061112651;6416.422521973045;6429.4534964526665;6100.725467353891;6387.457066149429;6442.291347951816;6442.677866106769;6477.77327793525;5937.317208521075;5953.553483488842;5961.2846458425265;5968.46283834457;5970.9701451492465;5961.254843144607;6021.367756385692;6028.638281703112;6044.637321760709;6061.605995610271 02:22:55 INFO - 2015-12-18 02:22:55,334 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.4722793427698;297.61904761904765;308.54797721338235;311.5000424318968;311.6784832311002;5201.141811601086;5263.736813159346;5313.203019547061;5331.813386531472;5335.0663633864115;5180;5198.766055527501;5205.375354957401;5248.422673505911;5250.789968401259;3919.8628048018327;4145.316022856225;4152.0657851983215;4152.979235103828;4161.646260067898;4006.439098526194;4016.3573828187496;4079.4492743479695;4112.958870411302;4123.340265557496;4063.8984025399454;4065.329220678599;4066.2883995300854;4073.40935564343;4077.87766367008;3852.9807350963347;3967.0479085019674;3986.80065996699;4074.7555146691143;4080.571539988303;3583.6953858922025;3590.3716849551483;3591.892243232707;3597.712183025352;3604.765690230153;5111.182210846247;5124.897502049938;5126.7692953816795;5127.53852153308;5136.9743151284;4675.251959686434;4677.555632214934;4679.485256621769;4685.086408150412;4685.625149987993;5411.431799661058;5532.419095994903;5538.335399752015;5538.919910617431;5540.612157149001;3905.531336239641;3913.589073147307;3913.8434462621462;3916.275489034509;3918.804059797027;5808.82573522795;5810.128480727924;5818.883622327572;5821.185034095188;5825.533957283449;4024.4566983457444;4025.3961905714377;4027.8993025174605;4028.093678922219;4029.9597004029583;3986.940195897064;4083.5508094109623;4086.959130408717;4091.7954102294766;4096.91806163875;4663.114008338405;4666.136764698542;4668.813247470063;4669.4630117536235;4669.509701481295;5522.972385138049;5531.751071201806;5535.6955367454375;5540.058190107691;5542.806001789918;1441.7188648213498;1453.694724107928;1454.9563513094624;1456.271864067966;1456.4902284200446;993.3791380387258;999.5651891427252;1012.4684540616236;1012.6354512375539;1017.3285631483186;4852.733099679481;4852.830150944771;4852.95147048525;4853.830115945995;4857.878553036202;5751.971240143773;5760.36635970043;5766.135079738073;5768.278965129359;5769.653820770767;4844.8304309349005;4849.636277279218;4851.708897466164;4855.951440485621;4857.271409288564;3034.135271447671;3073.8155710657434;3101.798383105091;3103.7206651401484;3113.252819323346;5449.863753406117;5453.509184173444;5455;5455.645383050089;5457.563394928476;5881.000229960831;5888.087346461305;5889.381614930457;5892.705364731746;5893.852653683606;5447.700376479332;5447.918281225785;5448.291722076105;5456.83629491108;5460.262864513399;5611.270534830446;5738.741756620879;5740.6268592541355;5754.19441278213;5756.280464941882;5606.0469720148485;5610.747516361692;5614.775408983595;5617.606767526234;5619.381867994435;5434.64674796137;5437.809676661456;5440.265564148947;5446.782128714807;5452.809151679672;3955.367141257385;4029.8388064477094;4038.6970977177416;4043.1711499143194;4043.636072753466;5723.7996670116345;5731.971340143273;5733.8566535836935;5739.282589676291;5742.16738572913;5508.283923089973;5510.752016159363;5518.641288316247;5520.171974203901;5523.8066667666435;5499.532539734168;5506.834794956158;5517.531009864046;5520.365158006881;5523.6685798852195;5302.098643230737;5402.621816472809;5408.188771684278;5411.70235637028;5414.539764120094;5388.811391601275;5540.030494663499;5555.777768889199;5559.805406810742;5562.3047119110115;5352.090144675492;5485.807996720096;5503.917441238465;5509.972450137724;5510.9448905510435 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: |5;yui.html;668.1447746883989;670.4669787518922;671.8186089755766;714.346373068642;724.3951300663946;10303.227257955647;10503.842442363371;10535.157187424997;10544.894551054487;10555.261131720783;10604.098651614622;13101.213927164354;13395.33023348831;13402.798958015637;13421.127626704258;635.4471609699568;797.696875187428;812.2162113560413;812.9674813007473;813.5647428625687;635.3329004545233;641.7048157847396;642.0145077306336;642.5309524047448;783.2285199078902;838.7232213369573;844.3456321350941;853.2065179383171;853.3258725606794;854.5556310718423;826.4545400035947;830.8047608811925;831.3432388413146;832.7085520067989;833.1377024779355;485.9975700121512;490.4506952213508;617.7220250887119;623.052959501555;625.0187206086446;9631.181349585293;9633.518324083838;9784.804303913881;9799;9833.360831545926;9995.200383969264;10667.786644267071;10748.408837513934;10983.505742241618;11554.248973816675;8605.096464871223;8714.128587141298;8843.823123537493;8932.553372331358;9578.856317155249;3235.7249633781157;3248.951265731016;3277.8033318001;3285.901422957315;3354.5303657487725;38207.23585528302;38670.61329386698;38869.22261554753;38960.22079558393;39227.60772392268;8417.537035463109;8515.957420212859;8576.887763964316;8637.309015278763;8748.65005399777;13446.46214151423;13464.730705385837;13473.528426505221;13477.19136851792;13481.393337299845;6046.3349031606485;6062.605930614496;6139.3553676863285;6172.444479996821;6296.5592408530965;3451.240727040047;3465.70541503975;3523.630018847984;3572.964270357315;3575.2670702505925;2567.910123145681;2605.2575016120695;2605.465879494737;2607;2614.751598598168;447.13033150522574;448.50664269304156;455.1852184589614;456.2221412491694;458.2896510408853;405.7362714235711;432.46374495625196;433.86767036053675;450.99774501127285;548.7283794521737;7038.213705942617;7102.14774227096;7247.840900087102;7293.234210407937;7298.051253337032;430.43827804715147;486.57181680121977;533.9786408543615;541.5396912624317;553.8144721518256;3285.5235990781202;3393.8642454302044;3430;3441.7934923904645;3457.22212502185;46181.30728039082;46632;47251.5274847254;47393.5260647396;47700.761496192295;41922.37116443256;42610.147797044505;42873.35689964653;43076.78461607672;43194.352084718754;39047.80476097601;39123.60876391257;39153.80423097866;39865.80402587927;39910.60089399127;6770.390664840188;6869.381755642016;7026.9648651756415;7032.613206273704;7146.213916469081;29089.272768180967;30171.09486715402;30593.54109688312;30752.538711918893;30870;36206;36216.275674485834;36469.27061458703;37558.2488350226;37751;9098.681546145854;9450.669226577036;9561.760955976157;9820.803583928138;9938.850917236103;10477;10567.524461399102;10723.785524289626;10838.945805270923;11096.500657470595;9394.765130871783;9893.35693179941;9982.500874956368;10036.598536058476;10620.628278010232;9659.178969787647;9767;9827.361221520578;9842.704718858446;9892.653757118755;9505.382150160218;9541.809163816824;9555.140037396668;9711.125998660154;9764.560594773395;8433.831323373375;8612.569371531523;8743.125687431206;8965.731028069169;9092.909070909207;8037.276645101969;8325;8443.240108390275;8627.43921645091;8889.688860889837 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434175324__endTimestamp 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4634.35 Median:4788.69 stddev:482.58 (10.1%) stddev-sans-first:456.98 02:22:55 INFO - 2015-12-18 02:22:55,338 DEBUG : BROWSER_OUTPUT: Values: 2602.5 2692.4 2693.3 2700.7 2720.1 4470.7 4635.6 4644.0 4657.6 4661.3 4548.5 4595.8 4691.6 4696.6 4714.5 4305.5 4353.0 4355.4 4380.0 4399.5 4381.3 4416.5 4438.6 4450.9 4486.2 4152.1 4231.6 4269.5 4284.2 4331.4 4344.5 4347.4 4362.4 4364.2 4389.5 4323.6 4324.8 4332.1 4339.5 4368.2 4455.1 4540.5 4578.5 4590.3 4663.3 5058.7 5079.9 5082.8 5083.8 5108.7 5083.6 5083.7 5085.9 5088.7 5140.1 4512.0 4626.1 4713.3 4715.6 4717.2 5042.7 5056.1 5105.9 5161.7 5167.6 4951.0 4954.0 4962.2 4962.6 5002.0 4878.8 5030.9 5045.9 5050.9 5058.6 4818.1 4883.2 4899.8 4931.8 4956.1 4970.7 4986.9 4990.9 4996.5 4997.6 4213.2 4222.9 4230.5 4258.7 4262.4 3556.7 3651.0 3677.4 3680.0 3706.1 4320.8 4355.5 4381.4 4384.8 4425.8 5078.9 5100.1 5100.5 5112.4 5146.0 4152.8 4237.0 4244.9 4246.3 4351.7 4457.3 4458.5 4465.1 4467.8 4486.6 4769.5 4788.7 4795.4 4802.4 4843.0 4827.5 4956.2 4957.9 4968.7 5055.1 4781.5 4784.9 4795.8 4796.9 4832.6 4944.1 4958.5 4961.1 4963.5 5007.3 4799.4 4893.3 4937.5 4939.7 5039.8 4881.2 4924.4 4957.7 4960.1 4963.3 4940.0 4943.9 4944.2 4952.0 4968.2 4640.8 4718.1 4733.0 4745.7 4890.4 4879.9 4890.4 4905.8 4909.5 4911.8 4801.0 4801.5 4802.7 4806.8 4834.6 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41521.98 Median:32212.54 stddev:70461.45 (218.7%) stddev-sans-first:70591.89 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: Values: 529.9 541.0 541.9 568.3 577.8 27208.0 27697.4 27728.3 27742.6 27769.0 27847.7 35993.3 36199.0 36244.3 36249.3 7833.9 7966.2 7969.2 7969.3 7978.0 7176.7 7370.9 7945.2 8046.9 8077.8 7216.5 10404.8 10640.4 10650.1 10658.2 10225.1 10344.9 10353.1 10358.1 10358.4 7042.0 7208.0 7208.7 9989.7 10160.3 25549.5 26041.3 41320.6 42362.2 42384.4 2768.0 2874.2 3037.8 3409.5 3599.7 26737.2 26992.6 27368.2 27389.9 27581.6 3458.7 3492.9 3506.9 3513.8 3631.7 175100.0 175479.0 175728.0 175944.0 176556.0 51863.5 53092.5 53135.5 53180.7 55228.7 55193.4 55252.0 55301.0 55477.4 55584.2 13360.7 13559.7 13638.9 13680.5 13687.2 9385.2 9505.3 9512.0 9551.9 9596.9 19300.5 19309.7 19437.0 19453.5 19506.6 6899.6 7261.1 7278.0 7300.4 7319.5 861.6 877.7 882.9 961.3 1050.3 27036.5 27122.1 27332.3 27623.6 27630.6 989.3 1013.3 1048.1 1068.3 1074.9 14119.0 14135.3 14234.0 14358.2 14369.3 273025.0 279076.0 279094.0 279165.0 279495.0 47639.5 47994.3 48029.0 48138.5 48145.0 1200.8 1209.1 1214.4 1233.7 1234.9 25398.9 26339.7 26715.2 27075.6 27170.5 41292.8 41747.2 41755.0 41818.6 41829.4 304947.0 309538.0 336434.0 344300.0 345618.0 26649.2 26953.6 26954.9 26994.2 27004.5 36525.5 38227.2 39163.8 39656.2 40355.4 29527.3 29641.1 29686.4 32481.0 34304.0 30838.5 32168.4 32644.2 32683.5 32716.5 31982.0 32256.7 32282.5 32417.0 32431.7 28314.2 29916.0 32952.8 33286.3 33645.7 23293.5 23628.6 23867.8 25151.5 25421.5 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23030.46 Median:433647.50 stddev:63387.44 (14.6%) stddev-sans-first:63542.33 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: Values: 324.8 327.3 334.7 334.9 337.0 12554.6 12982.5 14666.2 15273.4 16010.0 9800.5 10817.8 11825.3 15914.9 15931.0 4495.6 4550.5 4653.9 4671.6 4674.8 3472.4 3574.1 4611.6 5029.7 5189.7 5186.0 5188.9 5203.4 5208.3 5212.7 5059.9 5174.4 5219.2 5241.2 5257.5 5066.6 5067.2 5075.2 5078.4 5079.1 11941.2 17679.6 18252.9 19582.5 19602.5 1864.3 1876.6 1877.1 1915.0 2005.5 8498.4 8659.8 8696.7 8814.4 9425.0 1734.3 1891.1 1901.1 1908.3 1949.5 51356.7 54901.5 56600.7 57309.0 57430.1 9252.7 9466.1 9538.0 9722.9 9809.1 12394.8 12407.1 12413.6 12413.8 12419.9 6673.6 6706.4 6715.3 6731.8 6736.8 6304.9 6325.3 6349.8 6362.5 6381.0 4090.3 4143.1 4164.0 4164.8 4191.7 1602.8 1669.7 1697.6 1706.8 1765.9 807.7 857.3 964.9 991.6 1009.2 15131.0 15649.8 15801.7 16112.5 16131.3 776.2 841.9 848.1 876.7 882.9 8496.6 8716.5 8753.5 8782.4 8862.9 301452.0 308055.0 429594.0 433419.0 433876.0 62013.7 62235.0 67513.0 74732.0 76821.0 984.6 997.2 1001.6 1021.5 1022.3 14582.3 14601.5 14715.6 14795.5 14938.4 31905.2 31934.7 32689.7 33242.5 33314.0 41755.6 43004.6 43968.8 44280.3 47125.1 8838.7 8925.4 9047.6 9137.1 9145.1 15609.6 15861.3 16013.8 16106.7 16350.9 13169.2 13366.0 13752.5 13774.0 13921.4 13082.8 13141.6 13444.9 13596.3 13688.4 11077.7 11329.7 13385.4 13434.3 14120.5 8414.1 8478.2 8625.8 8711.2 8816.1 8862.9 8871.4 8897.9 8920.4 9004.1 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4920.67 Median:6098.80 stddev:2560.22 (42.0%) stddev-sans-first:2552.55 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: Values: 1251.6 1368.9 1392.0 1625.7 1704.4 6080.5 6971.7 7150.6 7165.4 7178.0 7164.1 7197.6 7239.6 7245.5 7261.0 1734.8 1769.8 2047.4 2089.0 2092.7 2044.2 2086.4 2089.2 2089.2 2092.0 1999.2 2003.0 2006.1 2007.0 2053.8 2031.7 2052.7 2063.2 2063.8 2065.1 2014.8 2072.2 2075.8 2077.0 2077.7 6936.1 6994.9 7004.9 7018.6 7029.1 4037.2 4117.1 4117.9 4118.7 4120.6 2563.1 2576.8 2674.5 2684.3 2684.8 846.2 857.4 884.4 900.0 900.8 9425.0 9429.7 9436.9 9443.3 9445.1 3659.9 3739.8 3761.4 3765.1 3791.4 8158.7 8159.6 8162.9 8165.1 8166.6 4121.3 4138.2 4140.3 4150.9 4152.1 3748.3 3756.2 3758.1 3760.3 3762.6 2946.1 3059.4 3322.8 3442.5 3445.8 1050.6 1105.4 1109.9 1111.0 1114.4 896.5 896.9 901.7 903.8 1197.2 6673.2 6731.6 6733.6 6741.5 6752.6 1019.4 1024.4 1028.1 1034.5 1051.6 5252.5 5289.2 5291.8 5301.9 5310.9 8112.4 8647.8 8656.7 8663.3 8664.9 8517.1 8520.3 8527.1 8542.8 8569.3 6503.4 6646.4 6746.3 6753.9 6781.3 6403.3 6423.7 6439.0 6441.2 6441.3 7474.2 7712.7 7724.3 7731.8 7732.5 7321.5 7350.7 7456.9 7459.6 7841.8 6043.3 6057.9 6096.9 6132.6 6150.9 5887.6 6245.3 6422.1 7016.4 7073.0 6414.9 6477.5 6533.8 6568.0 6581.4 6162.8 6314.1 6328.2 6416.4 6429.5 6100.7 6387.5 6442.3 6442.7 6477.8 5937.3 5953.6 5961.3 5968.5 5971.0 5961.3 6021.4 6028.6 6044.6 6061.6 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4603.94 Median:5203.26 stddev:1340.32 (25.8%) stddev-sans-first:1304.50 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: Values: 296.5 297.6 308.5 311.5 311.7 5201.1 5263.7 5313.2 5331.8 5335.1 5180.0 5198.8 5205.4 5248.4 5250.8 3919.9 4145.3 4152.1 4153.0 4161.6 4006.4 4016.4 4079.4 4113.0 4123.3 4063.9 4065.3 4066.3 4073.4 4077.9 3853.0 3967.0 3986.8 4074.8 4080.6 3583.7 3590.4 3591.9 3597.7 3604.8 5111.2 5124.9 5126.8 5127.5 5137.0 4675.3 4677.6 4679.5 4685.1 4685.6 5411.4 5532.4 5538.3 5538.9 5540.6 3905.5 3913.6 3913.8 3916.3 3918.8 5808.8 5810.1 5818.9 5821.2 5825.5 4024.5 4025.4 4027.9 4028.1 4030.0 3986.9 4083.6 4087.0 4091.8 4096.9 4663.1 4666.1 4668.8 4669.5 4669.5 5523.0 5531.8 5535.7 5540.1 5542.8 1441.7 1453.7 1455.0 1456.3 1456.5 993.4 999.6 1012.5 1012.6 1017.3 4852.7 4852.8 4853.0 4853.8 4857.9 5752.0 5760.4 5766.1 5768.3 5769.7 4844.8 4849.6 4851.7 4856.0 4857.3 3034.1 3073.8 3101.8 3103.7 3113.3 5449.9 5453.5 5455.0 5455.6 5457.6 5881.0 5888.1 5889.4 5892.7 5893.9 5447.7 5447.9 5448.3 5456.8 5460.3 5611.3 5738.7 5740.6 5754.2 5756.3 5606.0 5610.7 5614.8 5617.6 5619.4 5434.6 5437.8 5440.3 5446.8 5452.8 3955.4 4029.8 4038.7 4043.2 4043.6 5723.8 5732.0 5733.9 5739.3 5742.2 5508.3 5510.8 5518.6 5520.2 5523.8 5499.5 5506.8 5517.5 5520.4 5523.7 5302.1 5402.6 5408.2 5411.7 5414.5 5388.8 5540.0 5555.8 5559.8 5562.3 5352.1 5485.8 5503.9 5510.0 5510.9 02:22:55 INFO - 2015-12-18 02:22:55,339 DEBUG : BROWSER_OUTPUT: 02:22:55 INFO - 2015-12-18 02:22:55,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11548.53 Median:545.13 stddev:13182.16 (2418.2%) stddev-sans-first:13193.82 02:22:55 INFO - 2015-12-18 02:22:55,341 DEBUG : BROWSER_OUTPUT: Values: 668.1 670.5 671.8 714.3 724.4 10303.2 10503.8 10535.2 10544.9 10555.3 10604.1 13101.2 13395.3 13402.8 13421.1 635.4 797.7 812.2 813.0 813.6 635.3 641.7 642.0 642.5 783.2 838.7 844.3 853.2 853.3 854.6 826.5 830.8 831.3 832.7 833.1 486.0 490.5 617.7 623.1 625.0 9631.2 9633.5 9784.8 9799.0 9833.4 9995.2 10667.8 10748.4 10983.5 11554.2 8605.1 8714.1 8843.8 8932.6 9578.9 3235.7 3249.0 3277.8 3285.9 3354.5 38207.2 38670.6 38869.2 38960.2 39227.6 8417.5 8516.0 8576.9 8637.3 8748.7 13446.5 13464.7 13473.5 13477.2 13481.4 6046.3 6062.6 6139.4 6172.4 6296.6 3451.2 3465.7 3523.6 3573.0 3575.3 2567.9 2605.3 2605.5 2607.0 2614.8 447.1 448.5 455.2 456.2 458.3 405.7 432.5 433.9 451.0 548.7 7038.2 7102.1 7247.8 7293.2 7298.1 430.4 486.6 534.0 541.5 553.8 3285.5 3393.9 3430.0 3441.8 3457.2 46181.3 46632.0 47251.5 47393.5 47700.8 41922.4 42610.1 42873.4 43076.8 43194.4 39047.8 39123.6 39153.8 39865.8 39910.6 6770.4 6869.4 7027.0 7032.6 7146.2 29089.3 30171.1 30593.5 30752.5 30870.0 36206.0 36216.3 36469.3 37558.2 37751.0 9098.7 9450.7 9561.8 9820.8 9938.9 10477.0 10567.5 10723.8 10838.9 11096.5 9394.8 9893.4 9982.5 10036.6 10620.6 9659.2 9767.0 9827.4 9842.7 9892.7 9505.4 9541.8 9555.1 9711.1 9764.6 8433.8 8612.6 8743.1 8965.7 9092.9 8037.3 8325.0 8443.2 8627.4 8889.7 02:22:55 INFO - 2015-12-18 02:22:55,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:22:55 INFO - 2015-12-18 02:22:55,341 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-12-18 02:22:56,016 INFO : Browser exited with error code: 0 02:22:56 INFO - 2015-12-18 02:22:56,037 INFO : Completed test dromaeo_css (00:18:37) 02:22:56 INFO - 2015-12-18 02:22:56,037 INFO : Starting test kraken 02:22:56 INFO - 2015-12-18 02:22:56,037 DEBUG : operating with platform_type : linux_ 02:22:56 INFO - 2015-12-18 02:22:56,037 INFO : Initialising browser for kraken test... 02:22:56 INFO - 2015-12-18 02:22:56,044 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmctK8/profile http://localhost:54142/getInfo.html 02:23:00 INFO - 2015-12-18 02:23:00,462 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:23:00 INFO - 2015-12-18 02:23:00,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:23:00 INFO - 2015-12-18 02:23:00,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:23:00 INFO - 2015-12-18 02:23:00,462 DEBUG : BROWSER_OUTPUT: __metrics 02:23:00 INFO - 2015-12-18 02:23:00,551 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:23:00 INFO - 2015-12-18 02:23:00,627 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:00 ERROR - 2015-12-18 02:23:00,634 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 02:23:01 INFO - 2015-12-18 02:23:01,413 INFO : Browser initialized. 02:23:01 INFO - 2015-12-18 02:23:01,413 INFO : Running cycle 1/1 for kraken test... 02:23:01 INFO - 2015-12-18 02:23:01,414 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmctK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:23:13 INFO - 2015-12-18 02:23:13,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 150179840 02:23:13 INFO - 2015-12-18 02:23:13,315 DEBUG : BROWSER_OUTPUT: 02:23:15 INFO - 2015-12-18 02:23:15,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54142/tests/kraken/driver.html?testName=audio-beat-detection) 02:23:16 INFO - 2015-12-18 02:23:16,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 183631872 02:23:16 INFO - 2015-12-18 02:23:16,499 DEBUG : BROWSER_OUTPUT: 02:23:19 INFO - 2015-12-18 02:23:19,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54142/tests/kraken/driver.html?testName=audio-dft) 02:23:19 INFO - 2015-12-18 02:23:19,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 174530560 02:23:19 INFO - 2015-12-18 02:23:19,809 DEBUG : BROWSER_OUTPUT: 02:23:22 INFO - 2015-12-18 02:23:22,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54142/tests/kraken/driver.html?testName=audio-fft) 02:23:23 INFO - 2015-12-18 02:23:23,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 159870976 02:23:23 INFO - 2015-12-18 02:23:23,374 DEBUG : BROWSER_OUTPUT: 02:23:25 INFO - 2015-12-18 02:23:25,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54142/tests/kraken/driver.html?testName=audio-oscillator) 02:23:26 INFO - 2015-12-18 02:23:26,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 163991552 02:23:26 INFO - 2015-12-18 02:23:26,020 DEBUG : BROWSER_OUTPUT: 02:23:28 INFO - 2015-12-18 02:23:28,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:23:28 INFO - 2015-12-18 02:23:28,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 164245504 02:23:28 INFO - 2015-12-18 02:23:28,839 DEBUG : BROWSER_OUTPUT: 02:23:31 INFO - 2015-12-18 02:23:31,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54142/tests/kraken/driver.html?testName=imaging-darkroom) 02:23:32 INFO - 2015-12-18 02:23:32,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 164220928 02:23:32 INFO - 2015-12-18 02:23:32,411 DEBUG : BROWSER_OUTPUT: 02:23:35 INFO - 2015-12-18 02:23:35,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54142/tests/kraken/driver.html?testName=imaging-desaturate) 02:23:36 INFO - 2015-12-18 02:23:36,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 165273600 02:23:36 INFO - 2015-12-18 02:23:36,386 DEBUG : BROWSER_OUTPUT: 02:23:39 INFO - 2015-12-18 02:23:39,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54142/tests/kraken/driver.html?testName=json-parse-financial) 02:23:39 INFO - 2015-12-18 02:23:39,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 165224448 02:23:39 INFO - 2015-12-18 02:23:39,754 DEBUG : BROWSER_OUTPUT: 02:23:41 INFO - 2015-12-18 02:23:41,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:23:42 INFO - 2015-12-18 02:23:42,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 175165440 02:23:42 INFO - 2015-12-18 02:23:42,096 DEBUG : BROWSER_OUTPUT: 02:23:43 INFO - 2015-12-18 02:23:43,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:23:44 INFO - 2015-12-18 02:23:44,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 176123904 02:23:44 INFO - 2015-12-18 02:23:44,601 DEBUG : BROWSER_OUTPUT: 02:23:46 INFO - 2015-12-18 02:23:46,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:47 INFO - 2015-12-18 02:23:47,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 183558144 02:23:47 INFO - 2015-12-18 02:23:47,307 DEBUG : BROWSER_OUTPUT: 02:23:49 INFO - 2015-12-18 02:23:49,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:23:50 INFO - 2015-12-18 02:23:50,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 191377408 02:23:50 INFO - 2015-12-18 02:23:50,394 DEBUG : BROWSER_OUTPUT: 02:23:52 INFO - 2015-12-18 02:23:52,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:23:53 INFO - 2015-12-18 02:23:53,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 189243392 02:23:53 INFO - 2015-12-18 02:23:53,542 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54142/tests/kraken/driver.html?testName=ai-astar) 02:23:55 INFO - 2015-12-18 02:23:55,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 247308288 02:23:55 INFO - 2015-12-18 02:23:55,549 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;105;113;113;112;102;111;113;104 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;134;157;165;134;155;149;129;169;134 02:23:55 INFO - 2015-12-18 02:23:55,552 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;161;163;165;164;161;163;163;163 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;92;72;72;75;112;100;76 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;142;95;95;94;138;96;95;126 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;109;109;109;109;109 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;147;146;147;146;146;146;146;147 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;96;95;96;95 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;70;71;71;71;81;69;69 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;69;67;69;74;69 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;83;83;84;89;83;82;82;84;81 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;122;123;119;129;122;123;119;127;124 02:23:55 INFO - 2015-12-18 02:23:55,553 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;145;150;153;147;133;145;147;150;137 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;68;70;69;71;71;68;70 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434235550__endTimestamp 02:23:55 INFO - 2015-12-18 02:23:55,554 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:112.50 stddev:4.28 (3.8%) stddev-sans-first:4.53 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 105.0 113.0 113.0 112.0 102.0 111.0 113.0 104.0 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.50 stddev:14.19 (9.3%) stddev-sans-first:15.02 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: Values: 150.0 134.0 157.0 165.0 134.0 155.0 149.0 129.0 169.0 134.0 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,556 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 161.0 163.0 165.0 164.0 161.0 163.0 163.0 163.0 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:73.50 stddev:14.18 (19.3%) stddev-sans-first:14.53 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 92.0 72.0 72.0 75.0 112.0 100.0 76.0 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:95.00 stddev:19.81 (20.9%) stddev-sans-first:20.60 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 142.0 95.0 95.0 94.0 138.0 96.0 95.0 126.0 02:23:55 INFO - 2015-12-18 02:23:55,557 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:0.50 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,558 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:3.44 (4.8%) stddev-sans-first:3.64 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 70.0 71.0 71.0 71.0 81.0 69.0 69.0 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.85 (2.7%) stddev-sans-first:1.92 02:23:55 INFO - 2015-12-18 02:23:55,559 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 69.0 67.0 69.0 74.0 69.0 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:2.79 (3.3%) stddev-sans-first:2.30 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: Values: 89.0 83.0 83.0 84.0 89.0 83.0 82.0 82.0 84.0 81.0 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.50 stddev:3.47 (2.8%) stddev-sans-first:3.30 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: Values: 128.0 122.0 123.0 119.0 129.0 122.0 123.0 119.0 127.0 124.0 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:147.00 stddev:6.86 (4.7%) stddev-sans-first:6.42 02:23:55 INFO - 2015-12-18 02:23:55,560 DEBUG : BROWSER_OUTPUT: Values: 135.0 145.0 150.0 153.0 147.0 133.0 145.0 147.0 150.0 137.0 02:23:55 INFO - 2015-12-18 02:23:55,561 DEBUG : BROWSER_OUTPUT: 02:23:55 INFO - 2015-12-18 02:23:55,561 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.23 (1.8%) stddev-sans-first:1.22 02:23:55 INFO - 2015-12-18 02:23:55,561 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 70.0 69.0 71.0 71.0 68.0 70.0 02:23:55 INFO - 2015-12-18 02:23:55,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:23:55 INFO - 2015-12-18 02:23:55,561 DEBUG : BROWSER_OUTPUT: 02:23:56 INFO - 2015-12-18 02:23:56,440 INFO : Browser exited with error code: 0 02:23:56 INFO - 2015-12-18 02:23:56,490 INFO : Completed test kraken (00:01:00) 02:23:56 INFO - 2015-12-18 02:23:56,491 INFO : Starting test v8_7 02:23:56 INFO - 2015-12-18 02:23:56,491 DEBUG : operating with platform_type : linux_ 02:23:56 INFO - 2015-12-18 02:23:56,491 INFO : Initialising browser for v8_7 test... 02:23:56 INFO - 2015-12-18 02:23:56,497 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_LeSP/profile http://localhost:54142/getInfo.html 02:24:00 INFO - 2015-12-18 02:24:00,717 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:24:00 INFO - 2015-12-18 02:24:00,717 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:24:00 INFO - 2015-12-18 02:24:00,717 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:24:00 INFO - 2015-12-18 02:24:00,717 DEBUG : BROWSER_OUTPUT: __metrics 02:24:00 INFO - 2015-12-18 02:24:00,814 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:24:00 INFO - 2015-12-18 02:24:00,875 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:24:00 ERROR - 2015-12-18 02:24:00,895 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 02:24:01 INFO - 2015-12-18 02:24:01,765 INFO : Browser initialized. 02:24:01 INFO - 2015-12-18 02:24:01,766 INFO : Running cycle 1/1 for v8_7 test... 02:24:01 INFO - 2015-12-18 02:24:01,766 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_LeSP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:24:13 INFO - 2015-12-18 02:24:13,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 149921792 02:24:13 INFO - 2015-12-18 02:24:13,764 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54142/tests/v8_7/run.html (next: http://localhost:54142/tests/v8_7/run.html) 02:24:35 INFO - 2015-12-18 02:24:35,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 445505536 02:24:35 INFO - 2015-12-18 02:24:35,537 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,537 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |0;Richards;164.63615409944023 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.30099269526127 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |5;Earley;799.3605115907275 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |8;Splay;597.735399284863 02:24:35 INFO - 2015-12-18 02:24:35,538 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: __startTimestamp1450434275536__endTimestamp 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: Values: 164.6 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,539 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.30 Median:187.30 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: Values: 187.3 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: Values: 278.1 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,540 DEBUG : BROWSER_OUTPUT: Values: 5186.5 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: Values: 1988.1 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: Values: 799.4 02:24:35 INFO - 2015-12-18 02:24:35,541 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,542 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,542 DEBUG : BROWSER_OUTPUT: Values: 12048.2 02:24:35 INFO - 2015-12-18 02:24:35,542 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,542 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,543 DEBUG : BROWSER_OUTPUT: Values: 26921.1 02:24:35 INFO - 2015-12-18 02:24:35,544 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,544 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.74 Median:597.74 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,544 DEBUG : BROWSER_OUTPUT: Values: 597.7 02:24:35 INFO - 2015-12-18 02:24:35,544 DEBUG : BROWSER_OUTPUT: 02:24:35 INFO - 2015-12-18 02:24:35,545 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 02:24:35 INFO - 2015-12-18 02:24:35,545 DEBUG : BROWSER_OUTPUT: Values: 4864.1 02:24:35 INFO - 2015-12-18 02:24:35,545 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:24:35 INFO - 2015-12-18 02:24:35,545 DEBUG : BROWSER_OUTPUT: 02:24:36 INFO - 2015-12-18 02:24:36,468 INFO : Browser exited with error code: 0 02:24:36 INFO - 2015-12-18 02:24:36,485 INFO : Completed test v8_7 (00:00:39) 02:24:36 INFO - 2015-12-18 02:24:36,960 INFO : Completed test suite (00:20:18) 02:24:36 INFO - 2015-12-18 02:24:36,960 DEBUG : Working with test: dromaeo_css 02:24:36 INFO - 2015-12-18 02:24:36,960 DEBUG : Generating results file: dromaeo_css 02:24:36 INFO - 2015-12-18 02:24:36,961 DEBUG : Working with test: kraken 02:24:36 INFO - 2015-12-18 02:24:36,961 DEBUG : Generating results file: kraken 02:24:36 INFO - 2015-12-18 02:24:36,962 INFO : javascript benchmark 02:24:36 INFO - 2015-12-18 02:24:36,962 DEBUG : Working with test: v8_7 02:24:36 INFO - 2015-12-18 02:24:36,962 DEBUG : Generating results file: v8_7 02:24:36 INFO - 2015-12-18 02:24:36,963 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:37 INFO - 2015-12-18 02:24:37,020 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 02:24:37 INFO - 2015-12-18 02:24:37,020 DEBUG : process_Request line: dromaeo_css 6184.13 graph.html#tests=[[72,132,35]] 02:24:37 INFO - 2015-12-18 02:24:37,021 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:37 INFO - 2015-12-18 02:24:37,053 DEBUG : process_Request line: kraken 1522.60 graph.html#tests=[[232,132,35]] 02:24:37 INFO - 2015-12-18 02:24:37,053 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:37 INFO - 2015-12-18 02:24:37,083 DEBUG : process_Request line: v8_7 19817.18 graph.html#tests=[[230,132,35]] 02:24:37 INFO - 2015-12-18 02:24:37,084 INFO : javascript benchmark 02:24:37 INFO - 2015-12-18 02:24:37,088 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.4534847681985, 2692.448048150127, 2693.2593536777385, 2700.743429374209, 2720.088770261962, 4470.664700147486, 4635.582797548228, 4644.047970166116, 4657.580817726404, 4661.277501987193, 4548.454185497737, 4595.839145629903, 4691.601213896823, 4696.64775141864, 4714.528547145293, 4305.4833419989645, 4352.956470435302, 4355.412019377375, 4379.978100109495, 4399.472063352402, 4381.255186618267, 4416.536263692315, 4438.600525952664, 4450.866474005785, 4486.192485352635, 4152.1280531088505, 4231.555686652888, 4269.466316710411, 4284.228838809013, 4331.436913201295, 4344.45694288214, 4347.413099231595, 4362.411074504965, 4364.236258654754, 4389.495208051083, 4323.589259020388, 4324.783760811947, 4332.133573285356, 4339.47926248849, 4368.213721530124, 4455.108978204372, 4540.455145382575, 4578.473475550288, 4590.288505281686, 4663.282267846719, 5058.671186372874, 5079.949200507985, 5082.79668813247, 5083.79664813407, 5108.66793658411, 5083.61872859537, 5083.720395378253, 5085.923711144335, 5088.745562721886, 5140.126178549655, 4512.029913568598, 4626.05165940988, 4713.34013238147, 4715.552022557851, 4717.150912835654, 5042.747862606855, 5056.089903817275, 5105.8723531912, 5161.74191290434, 5167.612429067835, 4951.034548263054, 4954.033963377179, 4962.230854217602, 4962.5533701967, 5002.024605201951, 4878.780454879539, 5030.899382012412, 5045.899082018339, 5050.924236136461, 5058.620603454756, 4818.060478206786, 4883.194272944925, 4899.779509922062, 4931.778069986859, 4956.107900577858, 4970.676906001171, 4986.8753281168265, 4990.8752281193265, 4996.525330093636, 4997.600191984632, 4213.241616509058, 4222.915541689149, 4230.471191101113, 4258.701890867609, 4262.42457268271, 3556.6798988090677, 3650.9817450912574, 3677.3932301170544, 3679.9816000919823, 3706.129059670975, 4320.827166913351, 4355.499117601453, 4381.40850985113, 4384.846530371422, 4425.822967081345, 5078.873028174326, 5100.1074811907765, 5100.51545103222, 5112.36095488064, 5146.0, 4152.792360381969, 4237.0, 4244.915101697949, 4246.341817018367, 4351.6518678505645, 4457.3091170868565, 4458.5318541553315, 4465.062336909221, 4467.821287148543, 4486.6186374157905, 4769.451513075971, 4788.688735232199, 4795.376601041842, 4802.447718512346, 4843.0, 4827.468978412442, 4956.182229932021, 4957.900841983068, 4968.726720030433, 5055.064813009458, 4781.52184781533, 4784.880377990439, 4795.760211989317, 4796.856094317176, 4832.63755218353, 4944.1100601892, 4958.504149585013, 4961.05739909416, 4963.503649635008, 5007.29897814299, 4799.448063472745, 4893.290472881484, 4937.456879743154, 4939.703617782944, 5039.84880453587, 4881.194602890483, 4924.433690125538, 4957.702537847741, 4960.107180707508, 4963.280324353021, 4940.036692844861, 4943.8516844494725, 4944.184209605375, 4952.009598080471, 4968.155413579628, 4640.814367425265, 4718.103560323528, 4732.958749075198, 4745.715257084448, 4890.437599676083, 4879.926801098058, 4890.437599676083, 4905.8037678492465, 4909.5090490950615, 4911.8280860169725, 4801.039792041675, 4801.5438533339275, 4802.73584952817, 4806.7836947336755, 4834.564889159992], "unit": "score", "name": "dojo.html", "value": 4604.185793189827}, {"lowerIsBetter": false, "replicates": [529.8648844544641, 540.9594280428969, 541.88078622703, 568.3435631845217, 577.8382053025155, 27208.0, 27697.446051079016, 27728.30679233015, 27742.583861242074, 27769.0, 27847.721522784766, 35993.2801343973, 36199.0, 36244.275114497694, 36249.27501449976, 7833.882491762613, 7966.203379662045, 7969.2030796920135, 7969.282764551218, 7977.960110199441, 7176.748813791518, 7370.889436658427, 7945.245201705858, 8046.919530804705, 8077.7576672699915, 7216.530925489827, 10404.791904161912, 10640.361578305288, 10650.094741946943, 10658.200634952409, 10225.130863876579, 10344.948275258575, 10353.068223859813, 10358.067773900348, 10358.378497290187, 7042.0, 7208.0, 7208.675609597581, 9989.65036223736, 10160.288779785418, 25549.48901021969, 26041.348966275804, 41320.586794131974, 42362.15275694469, 42384.36423453651, 2768.0319640602975, 2874.238326843388, 3037.772167087477, 3409.454487282048, 3599.712023038177, 26737.19788406351, 26992.59511107335, 27368.178954631192, 27389.86305068462, 27581.58627620587, 3458.654134586546, 3492.9126771830906, 3506.8947931562093, 3513.8243087845763, 3631.7457777955556, 175100.0, 175478.99999999872, 175728.0, 175944.0, 176556.0, 51863.481365185864, 53092.46907530953, 53135.46864531383, 53180.73409632927, 55228.723856380464, 55193.44806551963, 55252.0, 55301.0, 55477.445225548036, 55584.16623750647, 13360.732785344433, 13559.728805424034, 13638.931805341108, 13680.452781888613, 13687.178769273876, 9385.202257808163, 9505.334626576212, 9511.953685094633, 9551.856722149174, 9596.856047159297, 19300.517487062934, 19309.710354344697, 19437.0, 19453.513662158275, 19506.609867802563, 6899.550224887556, 7261.128664560287, 7277.963610181915, 7300.379467745302, 7319.52423092508, 861.5606040919176, 877.7059685005595, 882.8875616722847, 961.3222678011984, 1050.2963014780116, 27036.459270814474, 27122.101452898107, 27332.316692082855, 27623.585646215324, 27630.585541216897, 989.2778271861581, 1013.2856336282903, 1048.1457612046158, 1068.3483075324045, 1074.9193810464246, 14119.0, 14135.293235338399, 14234.0, 14358.210298433478, 14369.281535923372, 273025.0, 279076.0, 279094.0, 279165.0, 279495.0, 47639.52360476351, 47994.28008579874, 48029.0, 48138.5186148134, 48145.0, 1200.8138738495547, 1209.0810983652486, 1214.3848681253912, 1233.7285797124798, 1234.851817781872, 25398.873005634854, 26339.73660263373, 26715.19854404371, 27075.59386609242, 27170.456590868467, 41292.79353603213, 41747.165056699305, 41755.0, 41818.58181418147, 41829.37255941102, 304947.0, 309538.0, 336434.0, 344300.0, 345618.0, 26649.200523984313, 26953.595696064967, 26954.865225673748, 26994.190174294803, 27004.45991080128, 36525.45211821772, 38227.235455291295, 39163.804180978914, 39656.206875862896, 40355.394669080575, 29527.26181845385, 29641.110766677033, 29686.406271874872, 32481.0, 34304.0, 30838.53742193824, 32168.404250012285, 32644.183895401853, 32683.50974735333, 32716.509252360756, 31982.0, 32256.677433226305, 32282.515762264055, 32417.0, 32431.675683242865, 28314.150575482767, 29916.0, 32952.835235823666, 33286.334273313914, 33645.66354336523, 23293.534129317657, 23628.645570316115, 23867.761322386556, 25151.530182034185, 25421.491570168862], "unit": "score", "name": "ext.html", "value": 16896.633225196812}, {"lowerIsBetter": false, "replicates": [324.81647868954025, 327.26244960902045, 334.6636630186663, 334.8744220917155, 337.0394376028319, 12554.560590379338, 12982.54561090362, 14666.193359365245, 15273.389064437422, 16009.999999999985, 9800.460974646392, 10817.83773243402, 11825.29048257103, 15914.920425397857, 15931.0, 4495.57292057254, 4550.499445061049, 4653.930191047137, 4671.6262698984, 4674.836380726675, 3472.3576138414346, 3574.124339536804, 4611.631069514431, 5029.723365214912, 5189.688618682872, 5186.040582492251, 5188.8702782430555, 5203.375594928595, 5208.322918020652, 5212.687238765668, 5059.873503162414, 5174.35320584925, 5219.164933610642, 5241.24002019705, 5257.5005374489365, 5066.620003499752, 5067.163917953533, 5075.162598171298, 5078.390593128811, 5079.060373830853, 11941.223820451643, 17679.5580110497, 18252.90873545637, 19582.51043723904, 19602.50993725154, 1864.3102052240622, 1876.6340563590106, 1877.0520886952138, 1914.9521261968562, 2005.548751530894, 8498.447600905922, 8659.783505412352, 8696.739097827012, 8814.382993190478, 9425.010373910778, 1734.332282071399, 1891.092275707668, 1901.115981068796, 1908.2748555548942, 1949.4931317857458, 51356.74321628443, 54901.45098549003, 56600.71699641517, 57309.0, 57430.138547921815, 9252.722418327461, 9466.148046675833, 9538.046195380546, 9722.854157187649, 9809.117179453884, 12394.81407778884, 12407.069469789622, 12413.627591172279, 12413.813792793115, 12419.93790031044, 6673.566218195801, 6706.362895524917, 6715.294894036154, 6731.798046058528, 6736.831579210559, 6304.873902522016, 6325.335839736854, 6349.777757778548, 6362.491000719931, 6380.968095159587, 4090.2637525245145, 4143.129942712004, 4164.0, 4164.7709375984, 4191.7275377101005, 1602.7675986981822, 1669.6577201673629, 1697.6434948660672, 1706.7951845778587, 1765.885217460861, 807.7334479621711, 857.2756021162108, 964.8697425847421, 991.6231831903831, 1009.1976878381557, 15131.0, 15649.765253521206, 15801.683966320608, 16112.516624501284, 16131.274092665859, 776.2198990014999, 841.9073901870789, 848.1427657389947, 876.6712482818942, 882.9293656507464, 8496.575171241413, 8716.520591367536, 8753.518556479456, 8782.429142105742, 8862.86705699415, 301452.0, 308055.0, 429594.0, 433419.0, 433876.0, 62013.689931550056, 62235.0, 67513.0, 74732.0, 76821.0, 984.5667906121283, 997.1872923567414, 1001.6143784642819, 1021.4892553723139, 1022.2792930983638, 14582.30253131977, 14601.488947886774, 14715.55853324402, 14795.482158124414, 14938.402463901322, 31905.202369940936, 31934.68065319317, 32689.673103268662, 33242.50136248006, 33314.0, 41755.58244417517, 43004.56995430131, 43968.82296181858, 44280.335794962455, 47125.05749885052, 8838.690645827364, 8925.419847709878, 9047.638094476411, 9137.08629137081, 9145.131212534798, 15609.609759755642, 15861.286242118902, 16013.8398616017, 16106.67786644284, 16350.918245408697, 13169.209847409185, 13366.0, 13752.518661846787, 13774.0, 13921.443142274196, 13082.803757943448, 13141.605751827461, 13444.932775336061, 13596.252206128758, 13688.384022719201, 11077.667669969915, 11329.660110196708, 13385.397657105259, 13434.261115638343, 14120.50578229757, 8414.074451810418, 8478.23695867375, 8625.784355391166, 8711.172438618321, 8816.074312197126, 8862.911370886466, 8871.423357481743, 8897.866532001895, 8920.375573709778, 9004.144606262395], "unit": "score", "name": "jquery.html", "value": 7967.3357341375595}, {"lowerIsBetter": false, "replicates": [1251.5807204586463, 1368.9178649281043, 1391.9977616116394, 1625.707372672919, 1704.4460550321144, 6080.543959203061, 6971.721131154754, 7150.606716630583, 7165.426765858731, 7178.0, 7164.140303163615, 7197.640117994092, 7239.6380180991, 7245.456590755688, 7260.96369518153, 1734.80917099119, 1769.7699299091164, 2047.37555045711, 2088.95822083559, 2092.696558998944, 2044.1721102953327, 2086.3636590839787, 2089.1643342662906, 2089.1956596710224, 2091.9581608367826, 1999.2302963359139, 2002.979970200294, 2006.0671787618755, 2006.9598608027832, 2053.7638171610233, 2031.7054027166052, 2052.7331446911808, 2063.1850419084376, 2063.752349718036, 2065.060397519125, 2014.8186663200236, 2072.1504183284933, 2075.802798734118, 2077.0237988145545, 2077.6779599162155, 6936.132983377078, 6994.930050699479, 7004.929950700479, 7018.649067546602, 7029.121359830021, 4037.1723796621623, 4117.135401565675, 4117.876463706094, 4118.691098167619, 4120.587941205886, 2563.128536297668, 2576.8196226264167, 2674.505216534928, 2684.315499547603, 2684.8389096654264, 846.1622993236651, 857.438377862501, 884.3986089459165, 899.9965038981554, 900.7703035725848, 9424.96325404205, 9429.669961551313, 9436.905630943671, 9443.291753118476, 9445.102715242041, 3659.853605855736, 3739.8130093495215, 3761.39817629178, 3765.134019175605, 3791.4123310886857, 8158.714444994397, 8159.592020398956, 8162.877556836652, 8165.101838797727, 8166.632501537445, 4121.278776214211, 4138.193052354822, 4140.254754144223, 4150.937735933963, 4152.148809494107, 3748.2878253131817, 3756.229972855558, 3758.0792705787258, 3760.3231418344963, 3762.6237376262156, 2946.071987324029, 3059.434004709136, 3322.8172450515453, 3442.4836274559016, 3445.8277086145595, 1050.6060227414719, 1105.4307031878589, 1109.9056580190613, 1110.9833352499718, 1114.3703807348984, 896.4845214001975, 896.852019416802, 901.6528636475005, 903.8418276801533, 1197.1500234833366, 6673.165854268216, 6731.562448440934, 6733.562318449285, 6741.460683145337, 6752.561083529653, 1019.403648865422, 1024.4365598920565, 1028.095276156977, 1034.4982683398546, 1051.64244156987, 5252.527272545412, 5289.18017707256, 5291.841244762663, 5301.867453313621, 5310.946890531122, 8112.391570632226, 8647.783805404915, 8656.6537338507, 8663.26362259215, 8664.8700269496, 8517.06312305646, 8520.318374530023, 8527.104654011364, 8542.786430339167, 8569.271611913056, 6503.447206987459, 6646.368594983469, 6746.325367463312, 6753.864922701617, 6781.25406205317, 6403.263624683221, 6423.678816059085, 6438.967805160944, 6441.194850643669, 6441.259255185526, 7474.215207403145, 7712.730054448068, 7724.343430808444, 7731.806704832424, 7732.497387669783, 7321.487495875238, 7350.7427240046345, 7456.888146677696, 7459.589722565311, 7841.803954901173, 6043.335233124265, 6057.939420605738, 6096.8780624388155, 6132.601380910227, 6150.907736383869, 5887.558433117448, 6245.313015568193, 6422.133012043314, 7016.438684905297, 7073.045138906387, 6414.903776443264, 6477.514186435942, 6533.771318003847, 6568.047633093079, 6581.407673309425, 6162.7534898605345, 6314.052892066226, 6328.24061112651, 6416.422521973045, 6429.4534964526665, 6100.725467353891, 6387.457066149429, 6442.291347951816, 6442.677866106769, 6477.77327793525, 5937.317208521075, 5953.553483488842, 5961.2846458425265, 5968.46283834457, 5970.9701451492465, 5961.254843144607, 6021.367756385692, 6028.638281703112, 6044.637321760709, 6061.605995610271], "unit": "score", "name": "mootools.html", "value": 4034.33529135891}, {"lowerIsBetter": false, "replicates": [296.4722793427698, 297.61904761904765, 308.54797721338235, 311.5000424318968, 311.6784832311002, 5201.141811601086, 5263.736813159346, 5313.203019547061, 5331.813386531472, 5335.0663633864115, 5180.0, 5198.766055527501, 5205.375354957401, 5248.422673505911, 5250.789968401259, 3919.8628048018327, 4145.316022856225, 4152.0657851983215, 4152.979235103828, 4161.646260067898, 4006.439098526194, 4016.3573828187496, 4079.4492743479695, 4112.958870411302, 4123.340265557496, 4063.8984025399454, 4065.329220678599, 4066.2883995300854, 4073.40935564343, 4077.87766367008, 3852.9807350963347, 3967.0479085019674, 3986.80065996699, 4074.7555146691143, 4080.571539988303, 3583.6953858922025, 3590.3716849551483, 3591.892243232707, 3597.712183025352, 3604.765690230153, 5111.182210846247, 5124.897502049938, 5126.7692953816795, 5127.53852153308, 5136.9743151284, 4675.251959686434, 4677.555632214934, 4679.485256621769, 4685.086408150412, 4685.625149987993, 5411.431799661058, 5532.419095994903, 5538.335399752015, 5538.919910617431, 5540.612157149001, 3905.531336239641, 3913.589073147307, 3913.8434462621462, 3916.275489034509, 3918.804059797027, 5808.82573522795, 5810.128480727924, 5818.883622327572, 5821.185034095188, 5825.533957283449, 4024.4566983457444, 4025.3961905714377, 4027.8993025174605, 4028.093678922219, 4029.9597004029583, 3986.940195897064, 4083.5508094109623, 4086.959130408717, 4091.7954102294766, 4096.91806163875, 4663.114008338405, 4666.136764698542, 4668.813247470063, 4669.4630117536235, 4669.509701481295, 5522.972385138049, 5531.751071201806, 5535.6955367454375, 5540.058190107691, 5542.806001789918, 1441.7188648213498, 1453.694724107928, 1454.9563513094624, 1456.271864067966, 1456.4902284200446, 993.3791380387258, 999.5651891427252, 1012.4684540616236, 1012.6354512375539, 1017.3285631483186, 4852.733099679481, 4852.830150944771, 4852.95147048525, 4853.830115945995, 4857.878553036202, 5751.971240143773, 5760.36635970043, 5766.135079738073, 5768.278965129359, 5769.653820770767, 4844.8304309349005, 4849.636277279218, 4851.708897466164, 4855.951440485621, 4857.271409288564, 3034.135271447671, 3073.8155710657434, 3101.798383105091, 3103.7206651401484, 3113.252819323346, 5449.863753406117, 5453.509184173444, 5455.0, 5455.645383050089, 5457.563394928476, 5881.000229960831, 5888.087346461305, 5889.381614930457, 5892.705364731746, 5893.852653683606, 5447.700376479332, 5447.918281225785, 5448.291722076105, 5456.83629491108, 5460.262864513399, 5611.270534830446, 5738.741756620879, 5740.6268592541355, 5754.19441278213, 5756.280464941882, 5606.0469720148485, 5610.747516361692, 5614.775408983595, 5617.606767526234, 5619.381867994435, 5434.64674796137, 5437.809676661456, 5440.265564148947, 5446.782128714807, 5452.809151679672, 3955.367141257385, 4029.8388064477094, 4038.6970977177416, 4043.1711499143194, 4043.636072753466, 5723.7996670116345, 5731.971340143273, 5733.8566535836935, 5739.282589676291, 5742.16738572913, 5508.283923089973, 5510.752016159363, 5518.641288316247, 5520.171974203901, 5523.8066667666435, 5499.532539734168, 5506.834794956158, 5517.531009864046, 5520.365158006881, 5523.6685798852195, 5302.098643230737, 5402.621816472809, 5408.188771684278, 5411.70235637028, 5414.539764120094, 5388.811391601275, 5540.030494663499, 5555.777768889199, 5559.805406810742, 5562.3047119110115, 5352.090144675492, 5485.807996720096, 5503.917441238465, 5509.972450137724, 5510.9448905510435], "unit": "score", "name": "prototype.html", "value": 4177.1820090917545}, {"lowerIsBetter": false, "replicates": [668.1447746883989, 670.4669787518922, 671.8186089755766, 714.346373068642, 724.3951300663946, 10303.227257955647, 10503.842442363371, 10535.157187424997, 10544.894551054487, 10555.261131720783, 10604.098651614622, 13101.213927164354, 13395.33023348831, 13402.798958015637, 13421.127626704258, 635.4471609699568, 797.696875187428, 812.2162113560413, 812.9674813007473, 813.5647428625687, 635.3329004545233, 641.7048157847396, 642.0145077306336, 642.5309524047448, 783.2285199078902, 838.7232213369573, 844.3456321350941, 853.2065179383171, 853.3258725606794, 854.5556310718423, 826.4545400035947, 830.8047608811925, 831.3432388413146, 832.7085520067989, 833.1377024779355, 485.9975700121512, 490.4506952213508, 617.7220250887119, 623.052959501555, 625.0187206086446, 9631.181349585293, 9633.518324083838, 9784.804303913881, 9799.0, 9833.360831545926, 9995.200383969264, 10667.786644267071, 10748.408837513934, 10983.505742241618, 11554.248973816675, 8605.096464871223, 8714.128587141298, 8843.823123537493, 8932.553372331358, 9578.856317155249, 3235.7249633781157, 3248.951265731016, 3277.8033318001, 3285.901422957315, 3354.5303657487725, 38207.23585528302, 38670.61329386698, 38869.22261554753, 38960.22079558393, 39227.60772392268, 8417.537035463109, 8515.957420212859, 8576.887763964316, 8637.309015278763, 8748.65005399777, 13446.46214151423, 13464.730705385837, 13473.528426505221, 13477.19136851792, 13481.393337299845, 6046.3349031606485, 6062.605930614496, 6139.3553676863285, 6172.444479996821, 6296.5592408530965, 3451.240727040047, 3465.70541503975, 3523.630018847984, 3572.964270357315, 3575.2670702505925, 2567.910123145681, 2605.2575016120695, 2605.465879494737, 2607.0, 2614.751598598168, 447.13033150522574, 448.50664269304156, 455.1852184589614, 456.2221412491694, 458.2896510408853, 405.7362714235711, 432.46374495625196, 433.86767036053675, 450.99774501127285, 548.7283794521737, 7038.213705942617, 7102.14774227096, 7247.840900087102, 7293.234210407937, 7298.051253337032, 430.43827804715147, 486.57181680121977, 533.9786408543615, 541.5396912624317, 553.8144721518256, 3285.5235990781202, 3393.8642454302044, 3430.0, 3441.7934923904645, 3457.22212502185, 46181.30728039082, 46632.0, 47251.5274847254, 47393.5260647396, 47700.761496192295, 41922.37116443256, 42610.147797044505, 42873.35689964653, 43076.78461607672, 43194.352084718754, 39047.80476097601, 39123.60876391257, 39153.80423097866, 39865.80402587927, 39910.60089399127, 6770.390664840188, 6869.381755642016, 7026.9648651756415, 7032.613206273704, 7146.213916469081, 29089.272768180967, 30171.09486715402, 30593.54109688312, 30752.538711918893, 30870.0, 36206.0, 36216.275674485834, 36469.27061458703, 37558.2488350226, 37751.0, 9098.681546145854, 9450.669226577036, 9561.760955976157, 9820.803583928138, 9938.850917236103, 10477.0, 10567.524461399102, 10723.785524289626, 10838.945805270923, 11096.500657470595, 9394.765130871783, 9893.35693179941, 9982.500874956368, 10036.598536058476, 10620.628278010232, 9659.178969787647, 9767.0, 9827.361221520578, 9842.704718858446, 9892.653757118755, 9505.382150160218, 9541.809163816824, 9555.140037396668, 9711.125998660154, 9764.560594773395, 8433.831323373375, 8612.569371531523, 8743.125687431206, 8965.731028069169, 9092.909070909207, 8037.276645101969, 8325.0, 8443.240108390275, 8627.43921645091, 8889.688860889837], "unit": "score", "name": "yui.html", "value": 5354.302199760976}], "name": "dromaeo_css", "value": 6184.126748620628}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 105.0, 113.0, 113.0, 112.0, 102.0, 111.0, 113.0, 104.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [150.0, 134.0, 157.0, 165.0, 134.0, 155.0, 149.0, 129.0, 169.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 163.0, 165.0, 164.0, 161.0, 163.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 92.0, 72.0, 72.0, 75.0, 112.0, 100.0, 76.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 142.0, 95.0, 95.0, 94.0, 138.0, 96.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 70.0, 71.0, 71.0, 71.0, 81.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 67.0, 69.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [89.0, 83.0, 83.0, 84.0, 89.0, 83.0, 82.0, 82.0, 84.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 123.0, 119.0, 129.0, 122.0, 123.0, 119.0, 127.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 150.0, 153.0, 147.0, 133.0, 145.0, 147.0, 150.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 70.0, 69.0, 71.0, 71.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1522.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "Richards", "value": 214.42434799999998}, {"lowerIsBetter": false, "replicates": [187.30099269526127], "unit": "score", "name": "DeltaBlue", "value": 353.0040020000002}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [597.735399284863], "unit": "score", "name": "Splay", "value": 136.33289930209372}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19817.178906489375}]} 02:24:37 INFO - RETURN: dromaeo_css: 6184.13 02:24:37 INFO - RETURN: kraken: 1522.60 02:24:37 INFO - RETURN: v8_7: 19817.18 02:24:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19817.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6184.13"}}} 02:24:37 INFO - Return code: 0 02:24:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:24:37 ERROR - # TBPL SUCCESS # 02:24:37 INFO - Running post-action listener: _resource_record_post_action 02:24:37 INFO - Running post-run listener: _resource_record_post_run 02:24:38 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555352064; Read time: 36; Write time: 500212 02:24:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235966464; Read time: 0; Write time: 239204 02:24:38 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319385600; Read time: 36; Write time: 261008 02:24:38 INFO - Running post-run listener: _upload_blobber_files 02:24:38 INFO - Blob upload gear active. 02:24:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:24:38 INFO - Copying logs to upload dir... 02:24:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.266885 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 02:24:38.144496) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:38.148581) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009953 build_url: 'https://queue.taskcluster.net/v1/task/jAjSaC04TEarKyxnjUNKgA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:38.204024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:38.204465) ========= 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=a9e534cca236dfa67d42a089000001c1-1450432356.18220-1738230475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:24:38.255444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:24:38.255836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:24:38.256207) ========= ========= Total master_lag: 0.34 =========