builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1450445013.28 results: success (0) buildid: 20151218044654 builduid: 2815efc7ec8c4bcbb261da5324f1d348 revision: 01a10d89e8a145f5f41e0d6f582ef431fe40fdbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.280184) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.280773) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.281183) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006398 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.343669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.343972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.419135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.419458) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.496874) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.497157) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.500572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.500865) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 05:23:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.5M=0s 2015-12-18 05:23:34 (60.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.345220 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.886812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.887227) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020206 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.944201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:33.944515) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 01a10d89e8a145f5f41e0d6f582ef431fe40fdbd --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 01a10d89e8a145f5f41e0d6f582ef431fe40fdbd --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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 05:23:35,132 truncating revision to first 12 chars 2015-12-18 05:23:35,132 Setting DEBUG logging. 2015-12-18 05:23:35,132 attempt 1/10 2015-12-18 05:23:35,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/01a10d89e8a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 05:23:35,610 unpacking tar archive at: fx-team-01a10d89e8a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:34.719760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:34.720096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:34.743695) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:34.744000) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 05:23:34.744420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-18 05:23:34.744697) ========= /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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:36 INFO - MultiFileLogger online at 20151218 05:23:36 in /builds/slave/test 05:23:36 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 05:23:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:36 INFO - {'append_to_log': False, 05:23:36 INFO - 'base_work_dir': '/builds/slave/test', 05:23:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:23:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:36 INFO - 'branch': 'Fx-Team-Non-PGO', 05:23:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:36 INFO - 'config_files': ('talos/linux_config.py',), 05:23:36 INFO - 'default_actions': ('clobber', 05:23:36 INFO - 'read-buildbot-config', 05:23:36 INFO - 'download-and-extract', 05:23:36 INFO - 'populate-webroot', 05:23:36 INFO - 'create-virtualenv', 05:23:36 INFO - 'install', 05:23:36 INFO - 'run-tests'), 05:23:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:36 INFO - 'download_minidump_stackwalk': True, 05:23:36 INFO - 'download_symbols': 'ondemand', 05:23:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:36 INFO - 'installer_path': 'installer.exe', 05:23:36 INFO - 'log_level': 'info', 05:23:36 INFO - 'log_name': 'talos', 05:23:36 INFO - 'log_to_console': True, 05:23:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:36 INFO - 'opt_config_files': (), 05:23:36 INFO - 'pip_index': False, 05:23:36 INFO - 'sps_profile': False, 05:23:36 INFO - 'sps_profile_interval': 0, 05:23:36 INFO - 'suite': 'dromaeojs', 05:23:36 INFO - 'system_bits': '64', 05:23:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:36 INFO - 'title': 'talos-linux64-ix-053', 05:23:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:36 INFO - 'use_talos_json': True, 05:23:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:36 INFO - 'work_dir': 'build'} 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running clobber step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: clobber 05:23:36 INFO - rmtree: /builds/slave/test/build 05:23:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running read-buildbot-config step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: read_buildbot_config 05:23:36 INFO - Using buildbot properties: 05:23:36 INFO - { 05:23:36 INFO - "project": "", 05:23:36 INFO - "product": "firefox", 05:23:36 INFO - "script_repo_revision": "production", 05:23:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:23:36 INFO - "repository": "", 05:23:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:23:36 INFO - "buildid": "20151218044654", 05:23:36 INFO - "pgo_build": "False", 05:23:36 INFO - "basedir": "/builds/slave/test", 05:23:36 INFO - "buildnumber": 1028, 05:23:36 INFO - "slavename": "talos-linux64-ix-053", 05:23:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:23:36 INFO - "platform": "ubuntu64_hw", 05:23:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:23:36 INFO - "branch": "fx-team", 05:23:36 INFO - "repo_path": "integration/fx-team", 05:23:36 INFO - "revision": "01a10d89e8a145f5f41e0d6f582ef431fe40fdbd", 05:23:36 INFO - "stage_platform": "linux64", 05:23:36 INFO - "builduid": "2815efc7ec8c4bcbb261da5324f1d348", 05:23:36 INFO - "slavebuilddir": "test" 05:23:36 INFO - } 05:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running download-and-extract step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: download_and_extract 05:23:36 INFO - mkdir: /builds/slave/test/build/tests 05:23: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')]} 05:23:36 INFO - https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/test_packages.json 05:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/test_packages.json 05:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:23:46 INFO - Downloaded 1302 bytes. 05:23:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:23:46 INFO - Using the following test package requirements: 05:23:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:23:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'jsshell-linux-x86_64.zip'], 05:23:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:23:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:23:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:23:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:23:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:23:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:23: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')]} 05:23:46 INFO - https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:47 INFO - Downloaded 21870954 bytes. 05:23:47 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 05:23:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:47 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 05:23:48 INFO - Return code: 0 05:23:48 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 05:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:48 INFO - https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:54 INFO - Downloaded 21870954 bytes. 05:23:54 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 05:23:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:23:54 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 05:23:55 INFO - Return code: 0 05:23:55 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')]} 05:23:55 INFO - https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:56 INFO - Downloaded 11132039 bytes. 05:23:56 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 05:23:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:56 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 05:23:56 INFO - Return code: 0 05:23: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')]} 05:23:56 INFO - https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/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 05:23:57 INFO - Downloaded 53014357 bytes. 05:23:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:23:57 INFO - mkdir: /builds/slave/test/properties 05:23:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:57 INFO - Contents: 05:23:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:23:57 INFO - Running post-action listener: _resource_record_post_action 05:23:57 INFO - Running post-action listener: set_extra_try_arguments 05:23:57 INFO - ##### 05:23:57 INFO - ##### Running populate-webroot step. 05:23:57 INFO - ##### 05:23:57 INFO - Running pre-action listener: _resource_record_pre_action 05:23:57 INFO - Running main action method: populate_webroot 05:23:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:57 INFO - '--tppagecycles', 05:23:57 INFO - '7'], 05:23:57 INFO - 'tests': ['tsvgm']}}, 05:23:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:23:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:23:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:23:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'tests': ['damp', 'tps']}, 05:23:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['damp', 'tps']}, 05:23:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:23:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:57 INFO - 'other': {'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'other_l64': {'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'other_nol64': {'tests': ['a11yr', 05:23:57 INFO - 'ts_paint', 05:23:57 INFO - 'tpaint', 05:23:57 INFO - 'sessionrestore', 05:23:57 INFO - 'sessionrestore_no_auto_restore']}, 05:23:57 INFO - 'svgr': {'tests': ['tsvgx', 05:23:57 INFO - 'tsvgr_opacity', 05:23:57 INFO - 'tart', 05:23:57 INFO - 'tscrollx', 05:23:57 INFO - 'cart']}, 05:23:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['tsvgx', 05:23:57 INFO - 'tsvgr_opacity', 05:23:57 INFO - 'tart', 05:23:57 INFO - 'tscrollx', 05:23:57 INFO - 'cart']}, 05:23:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'tests': ['tp5o']}, 05:23:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'talos_options': ['--e10s'], 05:23:57 INFO - 'tests': ['tp5o']}, 05:23:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'talos_options': ['--xperf_path', 05:23:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:57 INFO - 'tests': ['tp5n']}, 05:23:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:57 INFO - 'talos_options': ['--e10s', 05:23:57 INFO - '--xperf_path', 05:23:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:57 INFO - 'tests': ['tp5n']}}, 05:23:57 INFO - 'talos.zip': {'path': '', 05:23:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:57 INFO - Running post-action listener: _resource_record_post_action 05:23:57 INFO - ##### 05:23:57 INFO - ##### Running create-virtualenv step. 05:23:57 INFO - ##### 05:23:57 INFO - Running pre-action listener: _resource_record_pre_action 05:23:57 INFO - Running main action method: create_virtualenv 05:23:57 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:57 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 05:23:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:57 INFO - Using real prefix '/usr' 05:23:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:00 INFO - Installing pip.................done. 05:24:00 INFO - Return code: 0 05:24:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:00 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')]} 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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')]} 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:00 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 05:24:00 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 05:24:00 INFO - Using env: {'DISPLAY': ':0', 05:24:00 INFO - 'HOME': '/home/cltbld', 05:24:00 INFO - 'LANG': 'en_US.UTF-8', 05:24:00 INFO - 'LANGUAGE': 'en_US:en', 05:24:00 INFO - 'LOGNAME': 'cltbld', 05:24:00 INFO - 'MAIL': '/var/mail/cltbld', 05:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:00 INFO - 'MOZ_NO_REMOTE': '1', 05:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:00 INFO - 'NO_EM_RESTART': '1', 05:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:00 INFO - 'PWD': '/builds/slave/test', 05:24:00 INFO - 'SHELL': '/bin/bash', 05:24:00 INFO - 'SHLVL': '1', 05:24:00 INFO - 'TERM': 'linux', 05:24:00 INFO - 'TMOUT': '86400', 05:24:00 INFO - 'USER': 'cltbld', 05:24:00 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:00 INFO - '_': '/tools/buildbot/bin/python'} 05:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:00 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 05:24:00 INFO - Cleaning up... 05:24:00 INFO - Return code: 0 05:24:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24:00 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')]} 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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')]} 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:00 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 05:24:00 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 05:24:00 INFO - Using env: {'DISPLAY': ':0', 05:24:00 INFO - 'HOME': '/home/cltbld', 05:24:00 INFO - 'LANG': 'en_US.UTF-8', 05:24:00 INFO - 'LANGUAGE': 'en_US:en', 05:24:00 INFO - 'LOGNAME': 'cltbld', 05:24:00 INFO - 'MAIL': '/var/mail/cltbld', 05:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:00 INFO - 'MOZ_NO_REMOTE': '1', 05:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:00 INFO - 'NO_EM_RESTART': '1', 05:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:00 INFO - 'PWD': '/builds/slave/test', 05:24:00 INFO - 'SHELL': '/bin/bash', 05:24:00 INFO - 'SHLVL': '1', 05:24:00 INFO - 'TERM': 'linux', 05:24:00 INFO - 'TMOUT': '86400', 05:24:00 INFO - 'USER': 'cltbld', 05:24:00 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:00 INFO - '_': '/tools/buildbot/bin/python'} 05:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:00 INFO - Downloading/unpacking psutil>=0.7.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:24:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:02 INFO - Installing collected packages: psutil 05:24:02 INFO - Running setup.py install for psutil 05:24:02 INFO - building 'psutil._psutil_linux' extension 05:24:02 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 05:24:03 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 05:24:03 INFO - building 'psutil._psutil_posix' extension 05:24:03 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 05:24:03 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 05:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:03 INFO - Successfully installed psutil 05:24:03 INFO - Cleaning up... 05:24:03 INFO - Return code: 0 05:24:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:24:03 INFO - Using env: {'DISPLAY': ':0', 05:24:03 INFO - 'HOME': '/home/cltbld', 05:24:03 INFO - 'LANG': 'en_US.UTF-8', 05:24:03 INFO - 'LANGUAGE': 'en_US:en', 05:24:03 INFO - 'LOGNAME': 'cltbld', 05:24:03 INFO - 'MAIL': '/var/mail/cltbld', 05:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:03 INFO - 'MOZ_NO_REMOTE': '1', 05:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:03 INFO - 'NO_EM_RESTART': '1', 05:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:03 INFO - 'PWD': '/builds/slave/test', 05:24:03 INFO - 'SHELL': '/bin/bash', 05:24:03 INFO - 'SHLVL': '1', 05:24:03 INFO - 'TERM': 'linux', 05:24:03 INFO - 'TMOUT': '86400', 05:24:03 INFO - 'USER': 'cltbld', 05:24:03 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:03 INFO - '_': '/tools/buildbot/bin/python'} 05:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:24:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:24:05 INFO - Installing collected packages: mozsystemmonitor 05:24:05 INFO - Running setup.py install for mozsystemmonitor 05:24:05 INFO - Successfully installed mozsystemmonitor 05:24:05 INFO - Cleaning up... 05:24:05 INFO - Return code: 0 05:24:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:05 INFO - Using env: {'DISPLAY': ':0', 05:24:05 INFO - 'HOME': '/home/cltbld', 05:24:05 INFO - 'LANG': 'en_US.UTF-8', 05:24:05 INFO - 'LANGUAGE': 'en_US:en', 05:24:05 INFO - 'LOGNAME': 'cltbld', 05:24:05 INFO - 'MAIL': '/var/mail/cltbld', 05:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:05 INFO - 'MOZ_NO_REMOTE': '1', 05:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:05 INFO - 'NO_EM_RESTART': '1', 05:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:05 INFO - 'PWD': '/builds/slave/test', 05:24:05 INFO - 'SHELL': '/bin/bash', 05:24:05 INFO - 'SHLVL': '1', 05:24:05 INFO - 'TERM': 'linux', 05:24:05 INFO - 'TMOUT': '86400', 05:24:05 INFO - 'USER': 'cltbld', 05:24:05 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:05 INFO - '_': '/tools/buildbot/bin/python'} 05:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:07 INFO - Downloading docopt-0.6.1.tar.gz 05:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:08 INFO - Running setup.py install for blobuploader 05:24:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:08 INFO - Running setup.py install for requests 05:24:08 INFO - Running setup.py install for docopt 05:24:08 INFO - Successfully installed blobuploader requests docopt 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:08 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')]} 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 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')]} 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:08 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 05:24:08 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 05:24:08 INFO - Using env: {'DISPLAY': ':0', 05:24:08 INFO - 'HOME': '/home/cltbld', 05:24:08 INFO - 'LANG': 'en_US.UTF-8', 05:24:08 INFO - 'LANGUAGE': 'en_US:en', 05:24:08 INFO - 'LOGNAME': 'cltbld', 05:24:08 INFO - 'MAIL': '/var/mail/cltbld', 05:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:08 INFO - 'MOZ_NO_REMOTE': '1', 05:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:08 INFO - 'NO_EM_RESTART': '1', 05:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:08 INFO - 'PWD': '/builds/slave/test', 05:24:08 INFO - 'SHELL': '/bin/bash', 05:24:08 INFO - 'SHLVL': '1', 05:24:08 INFO - 'TERM': 'linux', 05:24:08 INFO - 'TMOUT': '86400', 05:24:08 INFO - 'USER': 'cltbld', 05:24:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:08 INFO - '_': '/tools/buildbot/bin/python'} 05:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:08 INFO - Running setup.py (path:/tmp/pip-KAzZSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:08 INFO - Running setup.py (path:/tmp/pip-qFulTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:08 INFO - Running setup.py (path:/tmp/pip-Jfb556-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:09 INFO - Running setup.py (path:/tmp/pip-ba8PUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:09 INFO - Running setup.py (path:/tmp/pip-f6eZWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:09 INFO - Running setup.py (path:/tmp/pip-yWBAd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:09 INFO - Running setup.py (path:/tmp/pip-Gw2UcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:09 INFO - Running setup.py (path:/tmp/pip-hvBmgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:09 INFO - Running setup.py (path:/tmp/pip-FTC4Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:09 INFO - Running setup.py (path:/tmp/pip-CkNBJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:09 INFO - Running setup.py (path:/tmp/pip-bB1AT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:09 INFO - Running setup.py (path:/tmp/pip-gqsAw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:09 INFO - Running setup.py (path:/tmp/pip-qc02IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:09 INFO - Running setup.py (path:/tmp/pip-JYMHaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:09 INFO - Running setup.py (path:/tmp/pip-7Ctg1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:09 INFO - Running setup.py (path:/tmp/pip-DOZ1Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:09 INFO - Running setup.py (path:/tmp/pip-KlxrES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:10 INFO - Running setup.py install for manifestparser 05:24:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Running setup.py install for mozcrash 05:24:10 INFO - Running setup.py install for mozdebug 05:24:10 INFO - Running setup.py install for mozdevice 05:24:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Running setup.py install for mozfile 05:24:10 INFO - Running setup.py install for mozhttpd 05:24:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Running setup.py install for mozinfo 05:24:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Running setup.py install for mozInstall 05:24:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:10 INFO - Running setup.py install for mozleak 05:24:10 INFO - Running setup.py install for mozlog 05:24:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Running setup.py install for moznetwork 05:24:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Running setup.py install for mozprocess 05:24:11 INFO - Running setup.py install for mozprofile 05:24:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Running setup.py install for mozrunner 05:24:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Running setup.py install for mozscreenshot 05:24:11 INFO - Running setup.py install for moztest 05:24:11 INFO - Running setup.py install for mozversion 05:24:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:11 INFO - Cleaning up... 05:24:11 INFO - Return code: 0 05:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:11 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')]} 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 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')]} 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:11 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 05:24:11 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 05:24:11 INFO - Using env: {'DISPLAY': ':0', 05:24:11 INFO - 'HOME': '/home/cltbld', 05:24:11 INFO - 'LANG': 'en_US.UTF-8', 05:24:11 INFO - 'LANGUAGE': 'en_US:en', 05:24:11 INFO - 'LOGNAME': 'cltbld', 05:24:11 INFO - 'MAIL': '/var/mail/cltbld', 05:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:11 INFO - 'MOZ_NO_REMOTE': '1', 05:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:11 INFO - 'NO_EM_RESTART': '1', 05:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:11 INFO - 'PWD': '/builds/slave/test', 05:24:11 INFO - 'SHELL': '/bin/bash', 05:24:11 INFO - 'SHLVL': '1', 05:24:11 INFO - 'TERM': 'linux', 05:24:11 INFO - 'TMOUT': '86400', 05:24:11 INFO - 'USER': 'cltbld', 05:24:11 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:11 INFO - '_': '/tools/buildbot/bin/python'} 05:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:12 INFO - Running setup.py (path:/tmp/pip-Xj3QmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:12 INFO - Running setup.py (path:/tmp/pip-81GjDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 INFO - Running setup.py (path:/tmp/pip-SqfB1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 INFO - Running setup.py (path:/tmp/pip-ghZRiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:12 INFO - Running setup.py (path:/tmp/pip-UCqNOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 INFO - Running setup.py (path:/tmp/pip-gUFcTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 INFO - Running setup.py (path:/tmp/pip-hEqY74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:12 INFO - Running setup.py (path:/tmp/pip-P1Le_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:12 INFO - Running setup.py (path:/tmp/pip-Gco4Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:12 INFO - Running setup.py (path:/tmp/pip-NqbXIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:12 INFO - Running setup.py (path:/tmp/pip-ONBsE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:12 INFO - Running setup.py (path:/tmp/pip-WEESUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:12 INFO - Running setup.py (path:/tmp/pip-LkGD6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:12 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)) 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:12 INFO - Running setup.py (path:/tmp/pip-V1xccb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:13 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)) 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:13 INFO - Running setup.py (path:/tmp/pip-aRgtES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:13 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)) 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:13 INFO - Running setup.py (path:/tmp/pip-1Hx1fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:13 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)) 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:13 INFO - Running setup.py (path:/tmp/pip-cB3Q35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:13 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)) 05:24:13 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)) 05:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:13 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)) 05:24:13 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)) 05:24:13 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)) 05:24:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:14 INFO - Downloading blessings-1.5.1.tar.gz 05:24:14 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 05:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:15 INFO - Installing collected packages: blessings 05:24:15 INFO - Running setup.py install for blessings 05:24:15 INFO - Successfully installed blessings 05:24:15 INFO - Cleaning up... 05:24:15 INFO - Return code: 0 05:24:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:15 INFO - Reading from file tmpfile_stdout 05:24:15 INFO - Current package versions: 05:24:15 INFO - argparse == 1.2.1 05:24:15 INFO - blessings == 1.5.1 05:24:15 INFO - blobuploader == 1.2.4 05:24:15 INFO - docopt == 0.6.1 05:24:15 INFO - manifestparser == 1.1 05:24:15 INFO - mozInstall == 1.12 05:24:15 INFO - mozcrash == 0.16 05:24:15 INFO - mozdebug == 0.1 05:24:15 INFO - mozdevice == 0.47 05:24:15 INFO - mozfile == 1.2 05:24:15 INFO - mozhttpd == 0.7 05:24:15 INFO - mozinfo == 0.9 05:24:15 INFO - mozleak == 0.1 05:24:15 INFO - mozlog == 3.1 05:24:15 INFO - moznetwork == 0.27 05:24:15 INFO - mozprocess == 0.22 05:24:15 INFO - mozprofile == 0.27 05:24:15 INFO - mozrunner == 6.11 05:24:15 INFO - mozscreenshot == 0.1 05:24:15 INFO - mozsystemmonitor == 0.0 05:24:15 INFO - moztest == 0.7 05:24:15 INFO - mozversion == 1.4 05:24:15 INFO - psutil == 3.1.1 05:24:15 INFO - requests == 1.2.3 05:24:15 INFO - wsgiref == 0.1.2 05:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:15 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 05:24:15 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 05:24:15 INFO - Using env: {'DISPLAY': ':0', 05:24:15 INFO - 'HOME': '/home/cltbld', 05:24:15 INFO - 'LANG': 'en_US.UTF-8', 05:24:15 INFO - 'LANGUAGE': 'en_US:en', 05:24:15 INFO - 'LOGNAME': 'cltbld', 05:24:15 INFO - 'MAIL': '/var/mail/cltbld', 05:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:15 INFO - 'MOZ_NO_REMOTE': '1', 05:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:15 INFO - 'NO_EM_RESTART': '1', 05:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:15 INFO - 'PWD': '/builds/slave/test', 05:24:15 INFO - 'SHELL': '/bin/bash', 05:24:15 INFO - 'SHLVL': '1', 05:24:15 INFO - 'TERM': 'linux', 05:24:15 INFO - 'TMOUT': '86400', 05:24:15 INFO - 'USER': 'cltbld', 05:24:15 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:15 INFO - '_': '/tools/buildbot/bin/python'} 05:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 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)) 05:24:15 INFO - Cleaning up... 05:24:15 INFO - Return code: 0 05:24:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:24:15 INFO - Using env: {'DISPLAY': ':0', 05:24:15 INFO - 'HOME': '/home/cltbld', 05:24:15 INFO - 'LANG': 'en_US.UTF-8', 05:24:15 INFO - 'LANGUAGE': 'en_US:en', 05:24:15 INFO - 'LOGNAME': 'cltbld', 05:24:15 INFO - 'MAIL': '/var/mail/cltbld', 05:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:15 INFO - 'MOZ_NO_REMOTE': '1', 05:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:15 INFO - 'NO_EM_RESTART': '1', 05:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:15 INFO - 'PWD': '/builds/slave/test', 05:24:15 INFO - 'SHELL': '/bin/bash', 05:24:15 INFO - 'SHLVL': '1', 05:24:15 INFO - 'TERM': 'linux', 05:24:15 INFO - 'TMOUT': '86400', 05:24:15 INFO - 'USER': 'cltbld', 05:24:15 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:15 INFO - '_': '/tools/buildbot/bin/python'} 05:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:15 INFO - Downloading/unpacking jsonschema 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:17 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 05:24:17 INFO - Downloading/unpacking functools32 (from jsonschema) 05:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:17 INFO - warning: no files found matching '*.txt' 05:24:17 INFO - no previously-included directories found matching 'build' 05:24:17 INFO - no previously-included directories found matching 'dist' 05:24:17 INFO - no previously-included directories found matching '.git*' 05:24:17 INFO - Installing collected packages: jsonschema, functools32 05:24:17 INFO - Running setup.py install for functools32 05:24:17 INFO - warning: no files found matching '*.txt' 05:24:17 INFO - no previously-included directories found matching 'build' 05:24:17 INFO - no previously-included directories found matching 'dist' 05:24:17 INFO - no previously-included directories found matching '.git*' 05:24:17 INFO - Successfully installed jsonschema functools32 05:24:17 INFO - Cleaning up... 05:24:17 INFO - Return code: 0 05:24:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:17 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 0x7f536a6d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, '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': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', '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 05:24:17 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 05:24:17 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 05:24:17 INFO - Using env: {'DISPLAY': ':0', 05:24:17 INFO - 'HOME': '/home/cltbld', 05:24:17 INFO - 'LANG': 'en_US.UTF-8', 05:24:17 INFO - 'LANGUAGE': 'en_US:en', 05:24:17 INFO - 'LOGNAME': 'cltbld', 05:24:17 INFO - 'MAIL': '/var/mail/cltbld', 05:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:17 INFO - 'MOZ_NO_REMOTE': '1', 05:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:17 INFO - 'NO_EM_RESTART': '1', 05:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:17 INFO - 'PWD': '/builds/slave/test', 05:24:17 INFO - 'SHELL': '/bin/bash', 05:24:17 INFO - 'SHLVL': '1', 05:24:17 INFO - 'TERM': 'linux', 05:24:17 INFO - 'TMOUT': '86400', 05:24:17 INFO - 'USER': 'cltbld', 05:24:17 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:17 INFO - '_': '/tools/buildbot/bin/python'} 05:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:18 INFO - Downloading/unpacking flake8 05:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:24:19 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 05:24:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:24:20 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 05:24:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 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 05:24:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:20 INFO - no previously-included directories found matching 'docs/_build' 05:24:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:24:20 INFO - Running setup.py install for pep8 05:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:20 INFO - no previously-included directories found matching 'docs/_build' 05:24:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:24:20 INFO - Cleaning up... 05:24:20 INFO - Return code: 0 05:24:20 INFO - Running post-action listener: _resource_record_post_action 05:24:20 INFO - Running post-action listener: _start_resource_monitoring 05:24:20 INFO - Starting resource monitoring. 05:24:20 INFO - ##### 05:24:20 INFO - ##### Running install step. 05:24:20 INFO - ##### 05:24:20 INFO - Running pre-action listener: _resource_record_pre_action 05:24:20 INFO - Running main action method: install 05:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:20 INFO - Reading from file tmpfile_stdout 05:24:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:21 INFO - Reading from file tmpfile_stdout 05:24:21 INFO - Output received: 05:24:21 INFO - Usage: mozinstall [options] installer 05:24:21 INFO - Options: 05:24:21 INFO - -h, --help show this help message and exit 05:24:21 INFO - -d DEST, --destination=DEST 05:24:21 INFO - Directory to install application into. [default: 05:24:21 INFO - "/builds/slave/test"] 05:24:21 INFO - --app=APP Application being installed. [default: firefox] 05:24:21 INFO - mkdir: /builds/slave/test/build/application 05:24:21 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'] 05:24:21 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 05:24:36 INFO - Reading from file tmpfile_stdout 05:24:36 INFO - Output received: 05:24:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:36 INFO - Running post-action listener: _resource_record_post_action 05:24:36 INFO - ##### 05:24:36 INFO - ##### Running run-tests step. 05:24:36 INFO - ##### 05:24:36 INFO - Running pre-action listener: _resource_record_pre_action 05:24:36 INFO - Running main action method: run_tests 05:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:36 INFO - Python 2.7.3 05:24:36 INFO - Return code: 0 05:24:36 INFO - grabbing minidump binary from tooltool 05:24: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')]} 05:24:36 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 0x1aa90b0>, '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 0x1aa9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:36 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 05:24:36 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 05:24:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:36 INFO - Return code: 0 05:24:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:24:37 INFO - Return code: 0 05:24:37 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/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 05:24:37 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/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 05:24:37 INFO - Using env: {'DISPLAY': ':0', 05:24:37 INFO - 'HOME': '/home/cltbld', 05:24:37 INFO - 'LANG': 'en_US.UTF-8', 05:24:37 INFO - 'LANGUAGE': 'en_US:en', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MAIL': '/var/mail/cltbld', 05:24:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SHLVL': '1', 05:24:37 INFO - 'TERM': 'linux', 05:24:37 INFO - 'TMOUT': '86400', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450444299.380615-974832600', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - '_': '/tools/buildbot/bin/python'} 05:24:37 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/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 05:24:37 INFO - mozversion INFO | application_buildid: 20151218044654 05:24:37 INFO - mozversion INFO | application_changeset: 01a10d89e8a145f5f41e0d6f582ef431fe40fdbd 05:24:37 INFO - mozversion INFO | application_display_name: Nightly 05:24:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:37 INFO - mozversion INFO | application_name: Firefox 05:24:37 INFO - mozversion INFO | application_remotingname: firefox 05:24:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:24:37 INFO - mozversion INFO | application_vendor: Mozilla 05:24:37 INFO - mozversion INFO | application_version: 46.0a1 05:24:37 INFO - mozversion INFO | platform_buildid: 20151218044654 05:24:37 INFO - mozversion INFO | platform_changeset: 01a10d89e8a145f5f41e0d6f582ef431fe40fdbd 05:24:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:37 INFO - mozversion INFO | platform_version: 46.0a1 05:24:37 INFO - 2015-12-18 05:24:37,670 DEBUG : using testdate: 1450445077 05:24:37 INFO - 2015-12-18 05:24:37,670 DEBUG : actual date: 1450445077 05:24:37 INFO - 2015-12-18 05:24:37,680 INFO : starting webserver on 'localhost:53992' 05:24:37 INFO - 2015-12-18 05:24:37,681 INFO : Starting test suite talos-linux64-ix-053 05:24:37 INFO - 2015-12-18 05:24:37,681 INFO : Starting test dromaeo_css 05:24:37 INFO - 2015-12-18 05:24:37,681 DEBUG : operating with platform_type : linux_ 05:24:37 INFO - 2015-12-18 05:24:37,681 INFO : Initialising browser for dromaeo_css test... 05:24:37 INFO - 2015-12-18 05:24:37,693 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGNKQ9/profile http://localhost:53992/getInfo.html 05:24:41 INFO - 2015-12-18 05:24:41,484 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:24:41 INFO - 2015-12-18 05:24:41,484 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:24:41 INFO - 2015-12-18 05:24:41,484 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:24:41 INFO - 2015-12-18 05:24:41,484 DEBUG : BROWSER_OUTPUT: __metrics 05:24:41 INFO - 2015-12-18 05:24:41,626 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] 05:24:41 INFO - 2015-12-18 05:24:41,682 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] 05:24:42 INFO - 2015-12-18 05:24:42,762 INFO : Browser initialized. 05:24:42 INFO - 2015-12-18 05:24:42,762 INFO : Running cycle 1/1 for dromaeo_css test... 05:24:42 INFO - 2015-12-18 05:24:42,762 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGNKQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:24:54 INFO - 2015-12-18 05:24:54,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 149016576 05:24:54 INFO - 2015-12-18 05:24:54,696 DEBUG : BROWSER_OUTPUT: 05:25:46 INFO - 2015-12-18 05:25:46,206 DEBUG : BROWSER_OUTPUT: 1450445146198 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] 05:27:58 INFO - 2015-12-18 05:27:58,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53992/tests/dromaeo/cssquery-ext.html) 05:27:59 INFO - 2015-12-18 05:27:59,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 231317504 05:27:59 INFO - 2015-12-18 05:27:59,385 DEBUG : BROWSER_OUTPUT: 05:31:01 INFO - 2015-12-18 05:31:01,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-ext.html (next: http://localhost:53992/tests/dromaeo/cssquery-jquery.html) 05:31:02 INFO - 2015-12-18 05:31:02,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 228331520 05:31:02 INFO - 2015-12-18 05:31:02,475 DEBUG : BROWSER_OUTPUT: 05:34:04 INFO - 2015-12-18 05:34:04,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53992/tests/dromaeo/cssquery-mootools.html) 05:34:05 INFO - 2015-12-18 05:34:05,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 230686720 05:34:05 INFO - 2015-12-18 05:34:05,288 DEBUG : BROWSER_OUTPUT: 05:37:07 INFO - 2015-12-18 05:37:07,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53992/tests/dromaeo/cssquery-prototype.html) 05:37:07 INFO - 2015-12-18 05:37:07,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 214388736 05:37:07 INFO - 2015-12-18 05:37:07,777 DEBUG : BROWSER_OUTPUT: 05:40:10 INFO - 2015-12-18 05:40:10,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53992/tests/dromaeo/cssquery-yui.html) 05:40:11 INFO - 2015-12-18 05:40:11,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 216657920 05:40:11 INFO - 2015-12-18 05:40:11,107 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/dromaeo/cssquery-yui.html (next: http://localhost:53992/tests/dromaeo/cssquery-dojo.html) 05:43:13 INFO - 2015-12-18 05:43:13,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 265494528 05:43:13 INFO - 2015-12-18 05:43:13,694 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,694 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:43:13 INFO - 2015-12-18 05:43:13,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:43:13 INFO - 2015-12-18 05:43:13,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:43:13 INFO - 2015-12-18 05:43:13,695 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:43:13 INFO - 2015-12-18 05:43:13,695 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2612.386089269022;2751.821131626444;2752.40823223007;2759.7654199393064;2769.7230276972305;4574.817007319703;4696.037312350968;4720.315554244632;4770.928436073462;4777.665563410563;4657.580817726404;4671.322658214557;4721.905561888769;4750.501197374278;4751.8812029699275;4295.441592592959;4329.264025115722;4365.759883206422;4393.143337049277;4422.137683151786;4412.1175764847;4437.2013037653205;4450.910981780378;4456.532064133268;4482.215612267856;4150.8547200848125;4262.339337402707;4263.25393056217;4267.658587313008;4393.209222339978;4380.671449641258;4398.494173170095;4412.602865742067;4417.403650507173;4423.336499525065;4365.716228445172;4390.626796722282;4390.78046097697;4396.1427521633295;4436.356728274414;4501.41481607389;4626.167289887819;4627.23650597651;4628.490866004737;4742.0990011897975;4975.5522003019905;5046.798128074873;5060.51925067118;5068.239764035387;5108.029474399852;5110.28456016158;5184.170532714786;5193.63644544882;5203.323567936182;5256.632035757499;4601.7699115044115;4717.882052948635;4725.102230576248;4781.474037855868;4797.4482934462285;5075.543201111844;5162.97418512905;5164.070467315844;5215.973920130375;5218.765155568009;5015.673981191211;5018.498150185025;5032.672876263105;5034.597232221414;5074.49255074497;4857.344258525124;4968.677035992649;4971.65198436106;5108.361454818148;5108.923366149511;4891.584215341736;4994.925076123861;4997.125503036954;5006.224035274538;5038.672486288379;5026.924596131061;5030.597552195815;5039.118154322979;5046.243063540498;5077.543021128116;4043.7169398142437;4200.957990420118;4238.830446782094;4243.193793179286;4279.657627389802;3583.982080089635;3652.1052342175803;3675.650813172744;3685.3182161300247;3713.832877520518;4377.4528183977;4381.9123617527475;4388.5830846069575;4406.515283318832;4409.867703968822;4828.927566086511;5133.614978876599;5135.35808023997;5135.6405051646025;5137.434882162959;4240.321548552217;4278.443802305743;4301.376300436419;4330.307150855848;4366.19225443294;4533.048059907391;4541.772911354486;4542.772861356919;4550.408446901882;4578.473475550288;4651.325557794168;4876.975615121902;4879.975600122048;4880.219164933594;4922.680025798311;4893.486183950777;5008.4240312364545;5008.824691135938;5027.698338099725;5034.16936205522;4814.277858321279;4857.319975203545;4869.634777391639;4871.975640121776;4881.780319885543;5029.899402012013;5039.689680682975;5059.266406371129;5063.594912406925;5101.591872650105;4881.438634557071;5008.824691135793;5014.07239660664;5127.717975511383;5192.532672059533;4806.2310030394965;4853.150698627796;4888.169011268022;4979;5013.298138260573;4940.184869496493;4946.431160416598;4950.108980383566;4950.1584730596605;4988.725620090785;4843.055604157155;4850.83022094225;4861.927071094007;4863.878403039811;4888.633352498648;4781.641376896677;4798.856034318976;4937.530934561211;4938.30863679078;4973.751312434436;4864.148773964472;4867.440244371943;4887.564129996604;4897.0450762101045;4932.062908047459 05:43:13 INFO - 2015-12-18 05:43:13,695 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.9786008559657;537.9031774280628;543.2014938041079;548.9104128305315;549.983500494985;25257.494850102987;34210.31579368411;34892.65107348926;35131.473027904605;35149.82425087871;38945.61054389455;39613;39673.40489892647;39693.40459893104;39701.40447893277;6927.099477067999;7062.364387205151;7522.924770752277;7728.227177282255;7728.6908523658985;9922;10284.640037598685;10290.639827606035;10295.433751143684;10295.63965261216;9760.2679799015;9830.803383932318;9840.409575425461;9899.257555683353;9915.752106197331;7142.1429428468655;7350.7427240046345;7355.705771769123;9876.40741555509;9913.306068575203;9747.805043899154;9888.604455821758;9899.406035637812;9899.851502227473;9911.306208565404;37011;37648.05879852998;37649.81175094107;37692.43461348082;37740.43389349162;2752.3394385347374;2786.6934637190097;2837.4325134973087;2842.701516340796;3495.4057810172076;28016.579751303747;28137.577936330767;28149.29626759327;28185.57721634177;28658;3305.289362787012;3314.171457135716;3317.154125697956;3367.696907278332;3439.1230236289584;218537;219993;220080;220922.89538552365;221069;55790.44209557934;56094.439055609735;56370;56493.43506564964;56595;51238.743806281476;52278;61106.08340874802;66258.66870665616;68167;13233.73532529344;13451.529196478075;13554.59336219915;13557.45770169202;13608.591742247749;9522.95238523803;9563.378380405251;9578.329516933747;9582.712518624452;9590.280728945218;19103.904480477788;19141.425757227305;19183.904080479788;19212.71180932287;19315.22739090449;7740.225977402215;7936.523808571505;7959.522428654183;8027.157148499324;8057.113717491071;889.301898010059;936.4007035497287;966.2849491376471;976.2385339435252;981.8379967305458;26405.735942640713;26753.732462675125;26844;26935.191944241706;26945;963.7686955130719;967.3808762392075;986.8766404199475;1026.6150193677372;1038.5689938675516;13916.30418479072;14594.781078283835;14734;14965.625859353386;15049.473268435551;309749;315740;316411;316586;316937;47761.28358074632;48241.5175848244;48378.09731416126;48416.27375589369;48487;1246.2024304445163;1260.9243445393306;1261.426051146726;1274.1399555300136;1274.350081458463;25470.872645636653;27036.32409189786;27472.862635686695;27569.586456203575;29247.70752292535;36853.63146368502;37780.62219377771;41826.581734183485;43035.569644303156;43073;200669;201633;203847;203997;204497;31997;35479.467807982386;39059.80470097631;39859.60140398559;39864.40203396893;37347.81326093461;39297.41053884251;39772.602273978046;39818;39833.80083099566;32083.35833283368;33304.83347583246;33656;33756.156096097795;33769.98690039303;33230.33539329248;33341.499877501374;33637;33788;38221.80889095537;33565.66434335723;33810.32379352448;33919.83040084784;38989.415158773205;39948.2010359797;28368.85815570909;29853.850730746206;30469.695303047574;30572.388552229277;30813.537796932615;23396.532069358178;23403.88298058499;23785.762142379048;23841.403964901016;23864.880675596512 05:43:13 INFO - 2015-12-18 05:43:13,695 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.3522903649461;324.42900495128566;326.1682709091815;327.23590416377755;327.2587589110665;12387.62837114888;12929.676758081052;15832.44586439475;16330.83669163308;16411.09738964358;12400.131990760628;14452.205128717917;14798.926005369958;15191.62020949474;15229.771553426708;4878.560929516343;4902.632302577321;5036.7481625918745;5043.117454445476;5047.0915235257635;3736.3461394255896;3793.5068441102617;4974.42794078682;5024.598032157437;5339.6262261641705;5556.86107847303;5570.693611851347;5574.916376254359;5581.134924086753;5584.106542953128;5457.317835270591;5549.667019978794;5758.107493338539;5775.855603609902;5792.855178620526;5008.84973450797;5017.598592112622;5038.874028149289;5040.6471546991725;5040.941402305521;18476.722849157275;18744.15651295695;18967.33614323492;19401.32095376669;19413.902930485398;1851.8240767127102;1974.141248556868;1975.3777560068677;1981.4154824326858;2003.1386503803358;8283.62723677436;8503.95748021262;8632.266257368132;8664.350173736932;8742.86885696715;1684.553593297777;1686.6036481426854;1722.3110755697696;1732.956676083108;1817.1368599914936;48270.27594586084;49704.75147624239;54797;55810;58313.708431458;9688.806223875483;9928.702138935843;10110.443925584164;10121.279382504992;10200.897991019994;12110.091743119301;12337.198082124632;12337.198082124813;12337.50649974009;12340.691482712824;6327.3988971047675;6409.455196308273;6409.519286053564;6770.661466926733;6837.247902730695;6126;6224.315325314212;6233.719482623293;6238.189035425366;6243.43809057178;4062.959370406258;4170.52039015511;4212.347086201644;4246.639035682002;4281.721688090264;1648.4751604765545;1688.50189194188;1714.6056407026454;1721.7675613792228;1766.6025144342677;805.6555423716956;820.7742870710603;851.7061613743249;857.3312816003527;857.6055014693186;14946.32741526634;15235.619109522351;15466;15789.526314210592;16731.07979061139;780.5199802121655;804.8511025460308;833.2084519706303;834.2116699718829;853.8249658819927;8391.916080839113;8683.305335573139;8709.738707838775;8892.555372231363;8927.419717718327;470015;472278;482398;482553;493307;72979.63510182415;75087.24912750912;75253.62373188099;76499;77231.61384193043;1037.2842738510403;1058.349115294104;1063.2291588598205;1066.1364294920984;1066.7493139112457;14139.151650900567;14668.706625867637;14720.263986800403;14908.478203262834;15017.6996460068;19676.606467870275;30669.693303066684;31310;31517.212069698442;32416.189595260308;39886;40116.59883401129;40316;40643;42787.47586536361;8718.694845680371;8951.641934322553;8956.552172391224;8959.641614335615;8986.14631609996;16845.747313790056;16886.40897568579;16978.830211697725;17162.485125446256;17255.56861078483;13182.868171318547;13816.516421925184;14140.78788818148;14247.786283205967;14373.496927607484;2225.6661500775012;2249.9437514061624;5222.947770522246;12752.617421477371;13589.158245457947;11267.492962816528;12297.954673852822;13925.164490130624;14038.438462461387;14048.227347495986;8074.798130046795;8088.63601137962;9014.639414423349;9042.819143617222;9304.302177336862;13904.791428128789;14071.859281407054;14392.496262630757;14406.927965360106;14528.709425811636 05:43:13 INFO - 2015-12-18 05:43:13,695 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1427.6930459951122;1670.31517077998;1709.3675340124155;1718.063655307858;1743.4072415378773;6317.810465686031;6749.561278516899;7105.396041336479;7106.289371062891;7107.0760801095785;7149.1778445478785;7268.636568171583;7273.7090516379285;7326.780196594097;7337.376323012537;2050.6411378008825;2082.760482544504;2085.5411809401908;2085.8539902206853;2087.5720477302116;2064.8657837240607;2066.1838573763353;2066.3387715930908;2122.8832414217213;2126.617208902397;1993.9700904486444;2015.4961259685078;2036.7657719362242;2040.010594861491;2040.2858999350258;2047.948801279965;2070.4616799632054;2073.1810934680716;2073.284716772711;2073.3054426767053;2026.432598872318;2039.3576023552534;2039.6022775558624;2040.0615716770303;2079.2618620389844;7241.167265764452;7308.0499535060635;7319.560826350383;7328.78013659591;7329.596872172028;4154.3976123462235;4225.7887105644595;4226.450561427026;4229.450171477688;4233.1322078973735;2615.1500762252344;2625.7899368050703;2638.93402664933;2658.840469571832;2670.772984296337;858.6007506509441;863.2144748279098;876.071364353787;889.2530274569393;894.9284057275468;9619.663311784054;9627.903720962771;9641.855372169422;9643.614255429775;9661.275404344631;3701.481792549045;3718.1262403335195;3772.3775577029483;3774.9622503774613;3858.3247931611854;8497.532635704973;8532.488050716976;8543.572821359032;8573.399862009599;8579.099194584478;4242.087951090531;4248.9787551062045;4257.3613957905945;4263.531011588722;4265.829366825292;3105.223694076481;3162.098801841464;3693.649103335179;3842.4620553122586;3850.4801851749653;3460.2906404187584;3475.8609655614;3497.0557949353533;3513.771604845728;3517.1734642359024;1093.0654290581597;1097.4896673047072;1101.432762127505;1104.2380757277454;1121.4448847820381;946.1531928923575;955.7323949294208;1190.2798806721983;1193.7672153930073;1223.853137623491;6891.689873955684;6906.861862762717;6910.652422777611;6925.168979722465;6958.965205174043;1084.1110289562641;1131.1290306463977;1135.3188087147646;1152.1819508149308;1163.336897968167;5315.096433606296;5370.0333939890415;5372;5381.730913454312;5383.434739352311;8463.619137138843;8823.779405514784;8894.110588941054;8904.065073167354;9006.189442950166;8712.128787121237;8721.127887211354;8797.29621630268;8800.823983520293;8896.466212027299;6919.204291506541;6953.513254072268;6975.3024697530855;6976.058232138596;6989.30106989297;6652.501062420241;6688;6698.162729658793;6711.194656641234;6736.730530778714;7900.170482099296;7951.483153594998;8082.7171049013;8088.029436467662;8149;8020.799480013046;8127.1466496017065;8161;8293.046299675374;8296.419250652638;5225.895482090261;5586.77652893896;5772.509336706259;5774.566907481872;5888.969430349586;6921.6193109379465;6936.930630693831;6945.479089068441;6965.373116419547;6976.930230697628;6401.775937842153;6477.8704425912165;6547.803565893031;6578.0790689304495;6643.302453242533;6379.4896408286295;6530.183727034121;6550.47596192313;6606.8678626426245;6614.371634694697;6572.638504882278;6577.473802095725;6606.4384527315715;6607.47140228771;6619.3380661933425;5811.215485909348;5971.552133589911;5979.820605381846;6068.059450785136;6118.908216376847;5990.910136348046;6050.546209034252;6057.091436284592;6064.02975523914;6068.332483426731 05:43:13 INFO - 2015-12-18 05:43:13,696 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.8177211900741;305.46391083648194;309.18221304649205;309.58051839757127;310.7219038960132;5224.973875130624;5278.524932756051;5354.384245811732;5383.192521121834;5389.703566303851;5217.373915130181;5301.946980530193;5303.920441193375;5305.7877684892555;5312.946870531294;3830.444585535096;3898.8440462381473;4097.180563887235;4099.959000410003;4107.240160570296;3993.2013597280516;4069.6540794032544;4096.918061638766;4098.159877225176;4110.568390319018;4055.3916912463073;4062.3297155969376;4065.125997910449;4066.8983275418204;4071.084006098619;3823.4073718573663;3934;3942.960570394288;4063.2889244382113;4065.613766692189;3553.0406790166767;3553.3959226931483;3555.5555555555557;3556.3598552260582;3560.287942411528;5079.466656001104;5081.974590127063;5092.363454568179;5105.183170692709;5110.361204849394;4647.047355292157;4659.813607455698;4660.627149828006;4661.650376221797;4663.766811659438;5338.759755810997;5512.503874651261;5516.7517461714315;5518.972405137949;5533.280673512458;3814.8664796731982;3814.923701525954;3825.6748176404762;3829.4064420014943;3833.674137698271;5720.199172115866;5815.621984571032;5825.883482330372;5827.271591051076;5829.300483941955;3894.045958740127;3927.0378757204667;3939.1530820873077;3940.310445671996;3940.566537680853;3918.4122381642983;3971.801409929492;3989.261986532501;3995.4006898965386;4056.0468289951837;4624.6993945394115;4625.329327247598;4629.074185162981;4632.420947381577;4634.745089020069;5513.58648101386;5515.034868897927;5524.14375771756;5525.475079867406;5526.613137080366;1387.6322774464775;1412.7033323002079;1413.1803553938691;1413.9010269281257;1414.1232435889608;913.456493386434;921.3783740616564;962.4273557233435;977.008336538414;981.0679854138597;4843.176659967814;4849.927251091236;4850.878728031827;4851.56335929768;4851.830185943475;5734.5125664319;5742.13867919807;5742.942570574324;5746.655200687972;5750.137479378127;4840.2255639097575;4845.370101886802;4846.927296090562;4851.272309153655;4852.975735121302;2856.3858770364473;2956.2904902823166;3059.9541006884915;3063.417950589381;3095.272610936428;5411.783528658888;5415.539679127318;5416.83749487516;5420.972895135578;5428.9185662215095;5927.051671732502;5937.287525496968;5941.316748573883;5941.940580594225;5949.077892926603;5481.561475082063;5482.862928426821;5491.560675145979;5495.670259784506;5496.203050557567;5660;5780.306363236438;5787.276590426197;5789.507891829242;5790.218320526675;5626.718664066699;5632.605717599728;5641.661500309994;5642.520385767256;5644.576656750678;5471.671699698031;5476.890462190813;5481.287432633732;5483.533899618577;5486.835394938158;3900.6099390060767;3968.1270120573427;3980.661643760313;3981.144054028398;3982.522097348221;5740.339860915881;5775.27809023872;5779.190913272229;5780.479756821906;5783.450572195635;5552.750126244409;5557.499825015768;5559.16612508127;5566.638168519034;5570.080936645408;5550.916736248879;5551.7779288828;5559.471850174227;5562;5568.192612071146;5312.229726689686;5436.809711660073;5456.072467680425;5456.154296084113;5461.863453413696;5582.748776305158;5599.188117722989;5599.216109744721;5604.635698679573;5607.691576963306;5465.781368745205;5472;5474.39781624029;5478.315210598676;5482.91775623358 05:43:13 INFO - 2015-12-18 05:43:13,699 DEBUG : BROWSER_OUTPUT: |5;yui.html;711.4770643576967;726.4116065986548;740.411372958498;741.6773703439004;766.9041369828772;8319.417640765141;8368.91631083689;8372.706955256568;8401.957990210056;8403.159684031609;9893.356931799446;10787.946060269687;10880.891191088087;10920.50857711403;10931.836022459649;615.2463232540125;784.8940393046951;797.0913158998746;801.9719309824158;801.9879701804477;784.9843003139933;796.0606484348466;797.2067792546425;799.3046049936563;800.131856935226;653.3335997282769;657.7434800427814;665.6538599928034;831.0235473318857;840.2437805974641;813.3452570680599;820.4420993724295;826.7189155687096;827.3463963468853;827.6606591297539;615.1603061820628;617.1452538234578;617.1483352972914;617.2469587103726;618.4526693875907;10621.203409744223;10818.945905270502;10821;10841.13270938323;10847.023767860852;10386.688399347957;10813.891861081367;11016.11871050322;11097.722556936142;11218.158638102175;8627.611757470866;8639.65441382344;8783.956080219621;8873.334499912533;8883.644654213824;3115.2990577120195;3187.42626327261;3195.3928753536984;3215.887443939451;3216.453202955503;37478.25043499142;37509.437358439645;37524.24951500982;37577.81211093927;37628.81185594082;8382.622781974826;8525.74422767318;8660.69687560945;8730;8753.693620723245;15753.212339382984;15766.369345226292;15771.921140394224;15782.605434864221;15796.842031579767;5791.536677065825;5848.619839710405;5905.586608937419;6024;6168.691565421711;3427.1946092668204;3438.4670376091744;3494.2487365216093;3550.3254381667402;3551.058969373118;2442.694663167104;2484.3292311075907;2485.453200295932;2486;2486.3411196033067;413.32215167125935;424.3189680562714;429.63910315335266;435.03639438642927;438.8507907311529;510.43086958041516;537.8467136866053;547.4580165635991;556.8246002509196;560.330405165823;6937.7224911002995;6960.651967401711;7022.789316320519;7058.858822823515;7094.11323584552;523.8035736598775;539.5467807042104;543.5977376741183;554.1493807006226;565.8787968881686;3049.2224482757197;3175.491921292582;3208.342289830579;3254.9674503255137;3318.3197444523817;51127.48872511302;55040.44959550353;55111;55421.445785541626;55645;41192.588074118874;41720.79139604283;43445.56554434415;43604.345934811005;43687;38147.23705525874;38490.23019539593;38878.61121388806;38927.61072389296;39126.99999999943;6970.163580370388;6976.6860491277;7099.609521476368;7124.3944264738075;7248.879528054028;29238.561421579117;29893.850530747208;30150;30200.64097115591;30680.846595766878;34198;34218.31563368669;34468.65531344755;34668.13329666779;37866.62133378631;8122.593870306579;8138.959305203436;8751.606177722146;9348.579313930753;9654.75863103428;8585.098564650621;8662.307015438875;8663.870041949249;8674.653013879626;8680.956595216983;9782.315237933277;9889.307748457539;9915.30592858493;9957.651482198089;10065.899341006496;9483.857742134012;9490.478023708762;9519.476428796206;9519.762005949906;9549.28380371461;9440.858387124335;9516.809663806824;9656.32405731592;9834.508274586386;9857.30998830075;7898.921010789819;8592.140785921358;8641.438306510057;8720.65971706608;8740.694075707319;8348.165183481604;8547.658093676184;8643.092475290256;8682.446898557146;8801.691940782042 05:43:13 INFO - 2015-12-18 05:43:13,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:43:13 INFO - 2015-12-18 05:43:13,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1048 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: __startTimestamp1450446193687__endTimestamp 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:43:13 INFO - 2015-12-18 05:43:13,700 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4676.86 Median:4850.83 stddev:488.96 (10.1%) stddev-sans-first:462.86 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: Values: 2612.4 2751.8 2752.4 2759.8 2769.7 4574.8 4696.0 4720.3 4770.9 4777.7 4657.6 4671.3 4721.9 4750.5 4751.9 4295.4 4329.3 4365.8 4393.1 4422.1 4412.1 4437.2 4450.9 4456.5 4482.2 4150.9 4262.3 4263.3 4267.7 4393.2 4380.7 4398.5 4412.6 4417.4 4423.3 4365.7 4390.6 4390.8 4396.1 4436.4 4501.4 4626.2 4627.2 4628.5 4742.1 4975.6 5046.8 5060.5 5068.2 5108.0 5110.3 5184.2 5193.6 5203.3 5256.6 4601.8 4717.9 4725.1 4781.5 4797.4 5075.5 5163.0 5164.1 5216.0 5218.8 5015.7 5018.5 5032.7 5034.6 5074.5 4857.3 4968.7 4971.7 5108.4 5108.9 4891.6 4994.9 4997.1 5006.2 5038.7 5026.9 5030.6 5039.1 5046.2 5077.5 4043.7 4201.0 4238.8 4243.2 4279.7 3584.0 3652.1 3675.7 3685.3 3713.8 4377.5 4381.9 4388.6 4406.5 4409.9 4828.9 5133.6 5135.4 5135.6 5137.4 4240.3 4278.4 4301.4 4330.3 4366.2 4533.0 4541.8 4542.8 4550.4 4578.5 4651.3 4877.0 4880.0 4880.2 4922.7 4893.5 5008.4 5008.8 5027.7 5034.2 4814.3 4857.3 4869.6 4872.0 4881.8 5029.9 5039.7 5059.3 5063.6 5101.6 4881.4 5008.8 5014.1 5127.7 5192.5 4806.2 4853.2 4888.2 4979.0 5013.3 4940.2 4946.4 4950.1 4950.2 4988.7 4843.1 4850.8 4861.9 4863.9 4888.6 4781.6 4798.9 4937.5 4938.3 4973.8 4864.1 4867.4 4887.6 4897.0 4932.1 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41384.27 Median:19194.03 stddev:65532.52 (341.4%) stddev-sans-first:65644.58 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: Values: 535.0 537.9 543.2 548.9 550.0 25257.5 34210.3 34892.7 35131.5 35149.8 38945.6 39613.0 39673.4 39693.4 39701.4 6927.1 7062.4 7522.9 7728.2 7728.7 9922.0 10284.6 10290.6 10295.4 10295.6 9760.3 9830.8 9840.4 9899.3 9915.8 7142.1 7350.7 7355.7 9876.4 9913.3 9747.8 9888.6 9899.4 9899.9 9911.3 37011.0 37648.1 37649.8 37692.4 37740.4 2752.3 2786.7 2837.4 2842.7 3495.4 28016.6 28137.6 28149.3 28185.6 28658.0 3305.3 3314.2 3317.2 3367.7 3439.1 218537.0 219993.0 220080.0 220922.9 221069.0 55790.4 56094.4 56370.0 56493.4 56595.0 51238.7 52278.0 61106.1 66258.7 68167.0 13233.7 13451.5 13554.6 13557.5 13608.6 9523.0 9563.4 9578.3 9582.7 9590.3 19103.9 19141.4 19183.9 19212.7 19315.2 7740.2 7936.5 7959.5 8027.2 8057.1 889.3 936.4 966.3 976.2 981.8 26405.7 26753.7 26844.0 26935.2 26945.0 963.8 967.4 986.9 1026.6 1038.6 13916.3 14594.8 14734.0 14965.6 15049.5 309749.0 315740.0 316411.0 316586.0 316937.0 47761.3 48241.5 48378.1 48416.3 48487.0 1246.2 1260.9 1261.4 1274.1 1274.4 25470.9 27036.3 27472.9 27569.6 29247.7 36853.6 37780.6 41826.6 43035.6 43073.0 200669.0 201633.0 203847.0 203997.0 204497.0 31997.0 35479.5 39059.8 39859.6 39864.4 37347.8 39297.4 39772.6 39818.0 39833.8 32083.4 33304.8 33656.0 33756.2 33770.0 33230.3 33341.5 33637.0 33788.0 38221.8 33565.7 33810.3 33919.8 38989.4 39948.2 28368.9 29853.9 30469.7 30572.4 30813.5 23396.5 23403.9 23785.8 23841.4 23864.9 05:43:13 INFO - 2015-12-18 05:43:13,701 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25868.85 Median:40216.30 stddev:78491.75 (195.2%) stddev-sans-first:78688.51 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: Values: 324.4 324.4 326.2 327.2 327.3 12387.6 12929.7 15832.4 16330.8 16411.1 12400.1 14452.2 14798.9 15191.6 15229.8 4878.6 4902.6 5036.7 5043.1 5047.1 3736.3 3793.5 4974.4 5024.6 5339.6 5556.9 5570.7 5574.9 5581.1 5584.1 5457.3 5549.7 5758.1 5775.9 5792.9 5008.8 5017.6 5038.9 5040.6 5040.9 18476.7 18744.2 18967.3 19401.3 19413.9 1851.8 1974.1 1975.4 1981.4 2003.1 8283.6 8504.0 8632.3 8664.4 8742.9 1684.6 1686.6 1722.3 1733.0 1817.1 48270.3 49704.8 54797.0 55810.0 58313.7 9688.8 9928.7 10110.4 10121.3 10200.9 12110.1 12337.2 12337.2 12337.5 12340.7 6327.4 6409.5 6409.5 6770.7 6837.2 6126.0 6224.3 6233.7 6238.2 6243.4 4063.0 4170.5 4212.3 4246.6 4281.7 1648.5 1688.5 1714.6 1721.8 1766.6 805.7 820.8 851.7 857.3 857.6 14946.3 15235.6 15466.0 15789.5 16731.1 780.5 804.9 833.2 834.2 853.8 8391.9 8683.3 8709.7 8892.6 8927.4 470015.0 472278.0 482398.0 482553.0 493307.0 72979.6 75087.2 75253.6 76499.0 77231.6 1037.3 1058.3 1063.2 1066.1 1066.7 14139.2 14668.7 14720.3 14908.5 15017.7 19676.6 30669.7 31310.0 31517.2 32416.2 39886.0 40116.6 40316.0 40643.0 42787.5 8718.7 8951.6 8956.6 8959.6 8986.1 16845.7 16886.4 16978.8 17162.5 17255.6 13182.9 13816.5 14140.8 14247.8 14373.5 2225.7 2249.9 5222.9 12752.6 13589.2 11267.5 12298.0 13925.2 14038.4 14048.2 8074.8 8088.6 9014.6 9042.8 9304.3 13904.8 14071.9 14392.5 14406.9 14528.7 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5049.20 Median:6068.20 stddev:2643.19 (43.6%) stddev-sans-first:2636.59 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: Values: 1427.7 1670.3 1709.4 1718.1 1743.4 6317.8 6749.6 7105.4 7106.3 7107.1 7149.2 7268.6 7273.7 7326.8 7337.4 2050.6 2082.8 2085.5 2085.9 2087.6 2064.9 2066.2 2066.3 2122.9 2126.6 1994.0 2015.5 2036.8 2040.0 2040.3 2047.9 2070.5 2073.2 2073.3 2073.3 2026.4 2039.4 2039.6 2040.1 2079.3 7241.2 7308.0 7319.6 7328.8 7329.6 4154.4 4225.8 4226.5 4229.5 4233.1 2615.2 2625.8 2638.9 2658.8 2670.8 858.6 863.2 876.1 889.3 894.9 9619.7 9627.9 9641.9 9643.6 9661.3 3701.5 3718.1 3772.4 3775.0 3858.3 8497.5 8532.5 8543.6 8573.4 8579.1 4242.1 4249.0 4257.4 4263.5 4265.8 3105.2 3162.1 3693.6 3842.5 3850.5 3460.3 3475.9 3497.1 3513.8 3517.2 1093.1 1097.5 1101.4 1104.2 1121.4 946.2 955.7 1190.3 1193.8 1223.9 6891.7 6906.9 6910.7 6925.2 6959.0 1084.1 1131.1 1135.3 1152.2 1163.3 5315.1 5370.0 5372.0 5381.7 5383.4 8463.6 8823.8 8894.1 8904.1 9006.2 8712.1 8721.1 8797.3 8800.8 8896.5 6919.2 6953.5 6975.3 6976.1 6989.3 6652.5 6688.0 6698.2 6711.2 6736.7 7900.2 7951.5 8082.7 8088.0 8149.0 8020.8 8127.1 8161.0 8293.0 8296.4 5225.9 5586.8 5772.5 5774.6 5889.0 6921.6 6936.9 6945.5 6965.4 6976.9 6401.8 6477.9 6547.8 6578.1 6643.3 6379.5 6530.2 6550.5 6606.9 6614.4 6572.6 6577.5 6606.4 6607.5 6619.3 5811.2 5971.6 5979.8 6068.1 6118.9 5990.9 6050.5 6057.1 6064.0 6068.3 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,703 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4594.46 Median:5309.01 stddev:1364.41 (25.7%) stddev-sans-first:1329.60 05:43:13 INFO - 2015-12-18 05:43:13,704 DEBUG : BROWSER_OUTPUT: Values: 298.8 305.5 309.2 309.6 310.7 5225.0 5278.5 5354.4 5383.2 5389.7 5217.4 5301.9 5303.9 5305.8 5312.9 3830.4 3898.8 4097.2 4100.0 4107.2 3993.2 4069.7 4096.9 4098.2 4110.6 4055.4 4062.3 4065.1 4066.9 4071.1 3823.4 3934.0 3943.0 4063.3 4065.6 3553.0 3553.4 3555.6 3556.4 3560.3 5079.5 5082.0 5092.4 5105.2 5110.4 4647.0 4659.8 4660.6 4661.7 4663.8 5338.8 5512.5 5516.8 5519.0 5533.3 3814.9 3814.9 3825.7 3829.4 3833.7 5720.2 5815.6 5825.9 5827.3 5829.3 3894.0 3927.0 3939.2 3940.3 3940.6 3918.4 3971.8 3989.3 3995.4 4056.0 4624.7 4625.3 4629.1 4632.4 4634.7 5513.6 5515.0 5524.1 5525.5 5526.6 1387.6 1412.7 1413.2 1413.9 1414.1 913.5 921.4 962.4 977.0 981.1 4843.2 4849.9 4850.9 4851.6 4851.8 5734.5 5742.1 5742.9 5746.7 5750.1 4840.2 4845.4 4846.9 4851.3 4853.0 2856.4 2956.3 3060.0 3063.4 3095.3 5411.8 5415.5 5416.8 5421.0 5428.9 5927.1 5937.3 5941.3 5941.9 5949.1 5481.6 5482.9 5491.6 5495.7 5496.2 5660.0 5780.3 5787.3 5789.5 5790.2 5626.7 5632.6 5641.7 5642.5 5644.6 5471.7 5476.9 5481.3 5483.5 5486.8 3900.6 3968.1 3980.7 3981.1 3982.5 5740.3 5775.3 5779.2 5780.5 5783.5 5552.8 5557.5 5559.2 5566.6 5570.1 5550.9 5551.8 5559.5 5562.0 5568.2 5312.2 5436.8 5456.1 5456.2 5461.9 5582.7 5599.2 5599.2 5604.6 5607.7 5465.8 5472.0 5474.4 5478.3 5482.9 05:43:13 INFO - 2015-12-18 05:43:13,705 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-12-18 05:43:13,705 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11514.74 Median:3391.97 stddev:13625.14 (401.7%) stddev-sans-first:13639.21 05:43:13 INFO - 2015-12-18 05:43:13,706 DEBUG : BROWSER_OUTPUT: Values: 711.5 726.4 740.4 741.7 766.9 8319.4 8368.9 8372.7 8402.0 8403.2 9893.4 10787.9 10880.9 10920.5 10931.8 615.2 784.9 797.1 802.0 802.0 785.0 796.1 797.2 799.3 800.1 653.3 657.7 665.7 831.0 840.2 813.3 820.4 826.7 827.3 827.7 615.2 617.1 617.1 617.2 618.5 10621.2 10818.9 10821.0 10841.1 10847.0 10386.7 10813.9 11016.1 11097.7 11218.2 8627.6 8639.7 8784.0 8873.3 8883.6 3115.3 3187.4 3195.4 3215.9 3216.5 37478.3 37509.4 37524.2 37577.8 37628.8 8382.6 8525.7 8660.7 8730.0 8753.7 15753.2 15766.4 15771.9 15782.6 15796.8 5791.5 5848.6 5905.6 6024.0 6168.7 3427.2 3438.5 3494.2 3550.3 3551.1 2442.7 2484.3 2485.5 2486.0 2486.3 413.3 424.3 429.6 435.0 438.9 510.4 537.8 547.5 556.8 560.3 6937.7 6960.7 7022.8 7058.9 7094.1 523.8 539.5 543.6 554.1 565.9 3049.2 3175.5 3208.3 3255.0 3318.3 51127.5 55040.4 55111.0 55421.4 55645.0 41192.6 41720.8 43445.6 43604.3 43687.0 38147.2 38490.2 38878.6 38927.6 39127.0 6970.2 6976.7 7099.6 7124.4 7248.9 29238.6 29893.9 30150.0 30200.6 30680.8 34198.0 34218.3 34468.7 34668.1 37866.6 8122.6 8139.0 8751.6 9348.6 9654.8 8585.1 8662.3 8663.9 8674.7 8681.0 9782.3 9889.3 9915.3 9957.7 10065.9 9483.9 9490.5 9519.5 9519.8 9549.3 9440.9 9516.8 9656.3 9834.5 9857.3 7898.9 8592.1 8641.4 8720.7 8740.7 8348.2 8547.7 8643.1 8682.4 8801.7 05:43:13 INFO - 2015-12-18 05:43:13,706 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:43:13 INFO - 2015-12-18 05:43:13,706 DEBUG : BROWSER_OUTPUT: 05:43:14 INFO - 2015-12-18 05:43:14,515 INFO : Browser exited with error code: 0 05:43:14 INFO - 2015-12-18 05:43:14,538 INFO : Completed test dromaeo_css (00:18:36) 05:43:14 INFO - 2015-12-18 05:43:14,538 INFO : Starting test kraken 05:43:14 INFO - 2015-12-18 05:43:14,538 DEBUG : operating with platform_type : linux_ 05:43:14 INFO - 2015-12-18 05:43:14,538 INFO : Initialising browser for kraken test... 05:43:14 INFO - 2015-12-18 05:43:14,545 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmYE_kt/profile http://localhost:53992/getInfo.html 05:43:18 INFO - 2015-12-18 05:43:18,356 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:43:18 INFO - 2015-12-18 05:43:18,356 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:43:18 INFO - 2015-12-18 05:43:18,356 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:43:18 INFO - 2015-12-18 05:43:18,356 DEBUG : BROWSER_OUTPUT: __metrics 05:43:18 INFO - 2015-12-18 05:43:18,424 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] 05:43:18 INFO - 2015-12-18 05:43:18,486 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] 05:43:19 INFO - 2015-12-18 05:43:19,581 INFO : Browser initialized. 05:43:19 INFO - 2015-12-18 05:43:19,581 INFO : Running cycle 1/1 for kraken test... 05:43:19 INFO - 2015-12-18 05:43:19,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmYE_kt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:43:31 INFO - 2015-12-18 05:43:31,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 149692416 05:43:31 INFO - 2015-12-18 05:43:31,575 DEBUG : BROWSER_OUTPUT: 05:43:34 INFO - 2015-12-18 05:43:34,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53992/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:34 INFO - 2015-12-18 05:43:34,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 183640064 05:43:34 INFO - 2015-12-18 05:43:34,731 DEBUG : BROWSER_OUTPUT: 05:43:37 INFO - 2015-12-18 05:43:37,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53992/tests/kraken/driver.html?testName=audio-dft) 05:43:38 INFO - 2015-12-18 05:43:38,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 175505408 05:43:38 INFO - 2015-12-18 05:43:38,020 DEBUG : BROWSER_OUTPUT: 05:43:41 INFO - 2015-12-18 05:43:41,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53992/tests/kraken/driver.html?testName=audio-fft) 05:43:41 INFO - 2015-12-18 05:43:41,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 160260096 05:43:41 INFO - 2015-12-18 05:43:41,609 DEBUG : BROWSER_OUTPUT: 05:43:43 INFO - 2015-12-18 05:43:43,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53992/tests/kraken/driver.html?testName=audio-oscillator) 05:43:44 INFO - 2015-12-18 05:43:44,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 162770944 05:43:44 INFO - 2015-12-18 05:43:44,255 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-12-18 05:43:46,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:47 INFO - 2015-12-18 05:43:47,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 165339136 05:43:47 INFO - 2015-12-18 05:43:47,039 DEBUG : BROWSER_OUTPUT: 05:43:50 INFO - 2015-12-18 05:43:50,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53992/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:50 INFO - 2015-12-18 05:43:50,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 165830656 05:43:50 INFO - 2015-12-18 05:43:50,626 DEBUG : BROWSER_OUTPUT: 05:43:54 INFO - 2015-12-18 05:43:54,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53992/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:54 INFO - 2015-12-18 05:43:54,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 166690816 05:43:54 INFO - 2015-12-18 05:43:54,660 DEBUG : BROWSER_OUTPUT: 05:43:57 INFO - 2015-12-18 05:43:57,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53992/tests/kraken/driver.html?testName=json-parse-financial) 05:43:58 INFO - 2015-12-18 05:43:58,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 164642816 05:43:58 INFO - 2015-12-18 05:43:58,052 DEBUG : BROWSER_OUTPUT: 05:43:59 INFO - 2015-12-18 05:43:59,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:00 INFO - 2015-12-18 05:44:00,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 174026752 05:44:00 INFO - 2015-12-18 05:44:00,375 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-12-18 05:44:02,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:02 INFO - 2015-12-18 05:44:02,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 173871104 05:44:02 INFO - 2015-12-18 05:44:02,873 DEBUG : BROWSER_OUTPUT: 05:44:04 INFO - 2015-12-18 05:44:04,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:05 INFO - 2015-12-18 05:44:05,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 181510144 05:44:05 INFO - 2015-12-18 05:44:05,578 DEBUG : BROWSER_OUTPUT: 05:44:08 INFO - 2015-12-18 05:44:08,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:08 INFO - 2015-12-18 05:44:08,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 190738432 05:44:08 INFO - 2015-12-18 05:44:08,703 DEBUG : BROWSER_OUTPUT: 05:44:11 INFO - 2015-12-18 05:44:11,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:11 INFO - 2015-12-18 05:44:11,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 188428288 05:44:11 INFO - 2015-12-18 05:44:11,872 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53992/tests/kraken/driver.html?testName=ai-astar) 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 246521856 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:44:13 INFO - 2015-12-18 05:44:13,886 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;113;113;102;112;113;105 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;135;163;170;138;149;147;130;175;130 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;160;162;163;162;162;163;163;160 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;84;106;75;71;71;100;92;74 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;129;94;95;95;132;94;95;128 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;110;109;109;109 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;149;146;146;146;147;147 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;96;95;96;94 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;71;72;71;75;72;81;69;69 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;68;68;69;68;68;68 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;92;89;83;82;83;83;92;83 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;128;118;120;124;126;123;117;132 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;148;148;149;145;136;141;147;150;137 05:44:13 INFO - 2015-12-18 05:44:13,887 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;70;69;70;69;70;70;71;68 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1013 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: __startTimestamp1450446253881__endTimestamp 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:3.98 (3.5%) stddev-sans-first:4.21 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 113.0 113.0 102.0 112.0 113.0 105.0 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:153.00 stddev:16.39 (10.7%) stddev-sans-first:17.15 05:44:13 INFO - 2015-12-18 05:44:13,888 DEBUG : BROWSER_OUTPUT: Values: 157.0 135.0 163.0 170.0 138.0 149.0 147.0 130.0 175.0 130.0 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 160.0 162.0 163.0 162.0 162.0 163.0 163.0 160.0 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:73.00 stddev:13.24 (18.1%) stddev-sans-first:13.48 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 84.0 106.0 75.0 71.0 71.0 100.0 92.0 74.0 05:44:13 INFO - 2015-12-18 05:44:13,889 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.50 stddev:16.92 (17.9%) stddev-sans-first:17.46 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 129.0 94.0 95.0 95.0 132.0 94.0 95.0 128.0 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 05:44:13 INFO - 2015-12-18 05:44:13,890 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 149.0 146.0 146.0 146.0 147.0 147.0 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 94.0 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:3.50 (4.9%) stddev-sans-first:3.68 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 72.0 71.0 75.0 72.0 81.0 69.0 69.0 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 05:44:13 INFO - 2015-12-18 05:44:13,891 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:4.27 (5.1%) stddev-sans-first:4.28 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 92.0 89.0 83.0 82.0 83.0 83.0 92.0 83.0 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.00 stddev:4.90 (3.9%) stddev-sans-first:4.94 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 128.0 118.0 120.0 124.0 126.0 123.0 117.0 132.0 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:147.50 stddev:5.99 (4.1%) stddev-sans-first:5.27 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: Values: 134.0 148.0 148.0 149.0 145.0 136.0 141.0 147.0 150.0 137.0 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 69.0 70.0 69.0 70.0 70.0 71.0 68.0 05:44:13 INFO - 2015-12-18 05:44:13,892 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:44:13 INFO - 2015-12-18 05:44:13,893 DEBUG : BROWSER_OUTPUT: 05:44:14 INFO - 2015-12-18 05:44:14,751 INFO : Browser exited with error code: 0 05:44:14 INFO - 2015-12-18 05:44:14,799 INFO : Completed test kraken (00:01:00) 05:44:14 INFO - 2015-12-18 05:44:14,800 INFO : Starting test v8_7 05:44:14 INFO - 2015-12-18 05:44:14,800 DEBUG : operating with platform_type : linux_ 05:44:14 INFO - 2015-12-18 05:44:14,800 INFO : Initialising browser for v8_7 test... 05:44:14 INFO - 2015-12-18 05:44:14,806 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCe9n2f/profile http://localhost:53992/getInfo.html 05:44:18 INFO - 2015-12-18 05:44:18,546 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:44:18 INFO - 2015-12-18 05:44:18,547 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:44:18 INFO - 2015-12-18 05:44:18,547 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:44:18 INFO - 2015-12-18 05:44:18,547 DEBUG : BROWSER_OUTPUT: __metrics 05:44:18 INFO - 2015-12-18 05:44:18,663 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] 05:44:18 INFO - 2015-12-18 05:44:18,731 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] 05:44:19 INFO - 2015-12-18 05:44:19,811 INFO : Browser initialized. 05:44:19 INFO - 2015-12-18 05:44:19,811 INFO : Running cycle 1/1 for v8_7 test... 05:44:19 INFO - 2015-12-18 05:44:19,811 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCe9n2f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:44:31 INFO - 2015-12-18 05:44:31,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 149819392 05:44:31 INFO - 2015-12-18 05:44:31,820 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53992/tests/v8_7/run.html (next: http://localhost:53992/tests/v8_7/run.html) 05:44:53 INFO - 2015-12-18 05:44:53,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 454774784 05:44:53 INFO - 2015-12-18 05:44:53,492 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7550140891762 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 05:44:53 INFO - 2015-12-18 05:44:53,493 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1996.007984031936 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |5;Earley;783.0853563038371 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |7;RegExp;27594.594594594593 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |8;Splay;598.5748218527316 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:44:53 INFO - 2015-12-18 05:44:53,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1450446293486__endTimestamp 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: Values: 165.8 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: Values: 186.3 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: Values: 279.8 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,495 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: Values: 5128.2 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: Values: 1996.0 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: Values: 783.1 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: Values: 12156.6 05:44:53 INFO - 2015-12-18 05:44:53,496 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27594.59 Median:27594.59 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: Values: 27594.6 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.57 Median:598.57 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: Values: 598.6 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:44:53 INFO - 2015-12-18 05:44:53,497 DEBUG : BROWSER_OUTPUT: 05:44:54 INFO - 2015-12-18 05:44:54,451 INFO : Browser exited with error code: 0 05:44:54 INFO - 2015-12-18 05:44:54,468 INFO : Completed test v8_7 (00:00:39) 05:44:54 INFO - 2015-12-18 05:44:54,501 INFO : Completed test suite (00:20:16) 05:44:54 INFO - 2015-12-18 05:44:54,501 DEBUG : Working with test: dromaeo_css 05:44:54 INFO - 2015-12-18 05:44:54,501 DEBUG : Generating results file: dromaeo_css 05:44:54 INFO - 2015-12-18 05:44:54,502 DEBUG : Working with test: kraken 05:44:54 INFO - 2015-12-18 05:44:54,502 DEBUG : Generating results file: kraken 05:44:54 INFO - 2015-12-18 05:44:54,503 INFO : javascript benchmark 05:44:54 INFO - 2015-12-18 05:44:54,503 DEBUG : Working with test: v8_7 05:44:54 INFO - 2015-12-18 05:44:54,503 DEBUG : Generating results file: v8_7 05:44:54 INFO - 2015-12-18 05:44:54,503 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:54 INFO - 2015-12-18 05:44:54,551 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:44:54 INFO - 2015-12-18 05:44:54,552 DEBUG : process_Request line: dromaeo_css 6249.93 graph.html#tests=[[72,132,35]] 05:44:54 INFO - 2015-12-18 05:44:54,552 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:54 INFO - 2015-12-18 05:44:54,580 DEBUG : process_Request line: kraken 1521.80 graph.html#tests=[[232,132,35]] 05:44:54 INFO - 2015-12-18 05:44:54,580 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:54 INFO - 2015-12-18 05:44:54,614 DEBUG : process_Request line: v8_7 19802.53 graph.html#tests=[[230,132,35]] 05:44:54 INFO - 2015-12-18 05:44:54,616 INFO : javascript benchmark 05:44:54 INFO - 2015-12-18 05:44:54,619 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2612.386089269022, 2751.821131626444, 2752.40823223007, 2759.7654199393064, 2769.7230276972305, 4574.817007319703, 4696.037312350968, 4720.315554244632, 4770.928436073462, 4777.665563410563, 4657.580817726404, 4671.322658214557, 4721.905561888769, 4750.501197374278, 4751.8812029699275, 4295.441592592959, 4329.264025115722, 4365.759883206422, 4393.143337049277, 4422.137683151786, 4412.1175764847, 4437.2013037653205, 4450.910981780378, 4456.532064133268, 4482.215612267856, 4150.8547200848125, 4262.339337402707, 4263.25393056217, 4267.658587313008, 4393.209222339978, 4380.671449641258, 4398.494173170095, 4412.602865742067, 4417.403650507173, 4423.336499525065, 4365.716228445172, 4390.626796722282, 4390.78046097697, 4396.1427521633295, 4436.356728274414, 4501.41481607389, 4626.167289887819, 4627.23650597651, 4628.490866004737, 4742.0990011897975, 4975.5522003019905, 5046.798128074873, 5060.51925067118, 5068.239764035387, 5108.029474399852, 5110.28456016158, 5184.170532714786, 5193.63644544882, 5203.323567936182, 5256.632035757499, 4601.7699115044115, 4717.882052948635, 4725.102230576248, 4781.474037855868, 4797.4482934462285, 5075.543201111844, 5162.97418512905, 5164.070467315844, 5215.973920130375, 5218.765155568009, 5015.673981191211, 5018.498150185025, 5032.672876263105, 5034.597232221414, 5074.49255074497, 4857.344258525124, 4968.677035992649, 4971.65198436106, 5108.361454818148, 5108.923366149511, 4891.584215341736, 4994.925076123861, 4997.125503036954, 5006.224035274538, 5038.672486288379, 5026.924596131061, 5030.597552195815, 5039.118154322979, 5046.243063540498, 5077.543021128116, 4043.7169398142437, 4200.957990420118, 4238.830446782094, 4243.193793179286, 4279.657627389802, 3583.982080089635, 3652.1052342175803, 3675.650813172744, 3685.3182161300247, 3713.832877520518, 4377.4528183977, 4381.9123617527475, 4388.5830846069575, 4406.515283318832, 4409.867703968822, 4828.927566086511, 5133.614978876599, 5135.35808023997, 5135.6405051646025, 5137.434882162959, 4240.321548552217, 4278.443802305743, 4301.376300436419, 4330.307150855848, 4366.19225443294, 4533.048059907391, 4541.772911354486, 4542.772861356919, 4550.408446901882, 4578.473475550288, 4651.325557794168, 4876.975615121902, 4879.975600122048, 4880.219164933594, 4922.680025798311, 4893.486183950777, 5008.4240312364545, 5008.824691135938, 5027.698338099725, 5034.16936205522, 4814.277858321279, 4857.319975203545, 4869.634777391639, 4871.975640121776, 4881.780319885543, 5029.899402012013, 5039.689680682975, 5059.266406371129, 5063.594912406925, 5101.591872650105, 4881.438634557071, 5008.824691135793, 5014.07239660664, 5127.717975511383, 5192.532672059533, 4806.2310030394965, 4853.150698627796, 4888.169011268022, 4979.0, 5013.298138260573, 4940.184869496493, 4946.431160416598, 4950.108980383566, 4950.1584730596605, 4988.725620090785, 4843.055604157155, 4850.83022094225, 4861.927071094007, 4863.878403039811, 4888.633352498648, 4781.641376896677, 4798.856034318976, 4937.530934561211, 4938.30863679078, 4973.751312434436, 4864.148773964472, 4867.440244371943, 4887.564129996604, 4897.0450762101045, 4932.062908047459], "unit": "score", "name": "dojo.html", "value": 4646.480006434551}, {"lowerIsBetter": false, "replicates": [534.9786008559657, 537.9031774280628, 543.2014938041079, 548.9104128305315, 549.983500494985, 25257.494850102987, 34210.31579368411, 34892.65107348926, 35131.473027904605, 35149.82425087871, 38945.61054389455, 39613.0, 39673.40489892647, 39693.40459893104, 39701.40447893277, 6927.099477067999, 7062.364387205151, 7522.924770752277, 7728.227177282255, 7728.6908523658985, 9922.0, 10284.640037598685, 10290.639827606035, 10295.433751143684, 10295.63965261216, 9760.2679799015, 9830.803383932318, 9840.409575425461, 9899.257555683353, 9915.752106197331, 7142.1429428468655, 7350.7427240046345, 7355.705771769123, 9876.40741555509, 9913.306068575203, 9747.805043899154, 9888.604455821758, 9899.406035637812, 9899.851502227473, 9911.306208565404, 37011.0, 37648.05879852998, 37649.81175094107, 37692.43461348082, 37740.43389349162, 2752.3394385347374, 2786.6934637190097, 2837.4325134973087, 2842.701516340796, 3495.4057810172076, 28016.579751303747, 28137.577936330767, 28149.29626759327, 28185.57721634177, 28658.0, 3305.289362787012, 3314.171457135716, 3317.154125697956, 3367.696907278332, 3439.1230236289584, 218537.0, 219993.0, 220080.0, 220922.89538552365, 221069.0, 55790.44209557934, 56094.439055609735, 56370.0, 56493.43506564964, 56595.0, 51238.743806281476, 52278.0, 61106.08340874802, 66258.66870665616, 68167.0, 13233.73532529344, 13451.529196478075, 13554.59336219915, 13557.45770169202, 13608.591742247749, 9522.95238523803, 9563.378380405251, 9578.329516933747, 9582.712518624452, 9590.280728945218, 19103.904480477788, 19141.425757227305, 19183.904080479788, 19212.71180932287, 19315.22739090449, 7740.225977402215, 7936.523808571505, 7959.522428654183, 8027.157148499324, 8057.113717491071, 889.301898010059, 936.4007035497287, 966.2849491376471, 976.2385339435252, 981.8379967305458, 26405.735942640713, 26753.732462675125, 26844.0, 26935.191944241706, 26945.0, 963.7686955130719, 967.3808762392075, 986.8766404199475, 1026.6150193677372, 1038.5689938675516, 13916.30418479072, 14594.781078283835, 14734.0, 14965.625859353386, 15049.473268435551, 309749.0, 315740.0, 316411.0, 316586.0, 316937.0, 47761.28358074632, 48241.5175848244, 48378.09731416126, 48416.27375589369, 48487.0, 1246.2024304445163, 1260.9243445393306, 1261.426051146726, 1274.1399555300136, 1274.350081458463, 25470.872645636653, 27036.32409189786, 27472.862635686695, 27569.586456203575, 29247.70752292535, 36853.63146368502, 37780.62219377771, 41826.581734183485, 43035.569644303156, 43073.0, 200669.0, 201633.0, 203847.0, 203997.0, 204497.0, 31997.0, 35479.467807982386, 39059.80470097631, 39859.60140398559, 39864.40203396893, 37347.81326093461, 39297.41053884251, 39772.602273978046, 39818.0, 39833.80083099566, 32083.35833283368, 33304.83347583246, 33656.0, 33756.156096097795, 33769.98690039303, 33230.33539329248, 33341.499877501374, 33637.0, 33788.0, 38221.80889095537, 33565.66434335723, 33810.32379352448, 33919.83040084784, 38989.415158773205, 39948.2010359797, 28368.85815570909, 29853.850730746206, 30469.695303047574, 30572.388552229277, 30813.537796932615, 23396.532069358178, 23403.88298058499, 23785.762142379048, 23841.403964901016, 23864.880675596512], "unit": "score", "name": "ext.html", "value": 17398.140313311847}, {"lowerIsBetter": false, "replicates": [324.3522903649461, 324.42900495128566, 326.1682709091815, 327.23590416377755, 327.2587589110665, 12387.62837114888, 12929.676758081052, 15832.44586439475, 16330.83669163308, 16411.09738964358, 12400.131990760628, 14452.205128717917, 14798.926005369958, 15191.62020949474, 15229.771553426708, 4878.560929516343, 4902.632302577321, 5036.7481625918745, 5043.117454445476, 5047.0915235257635, 3736.3461394255896, 3793.5068441102617, 4974.42794078682, 5024.598032157437, 5339.6262261641705, 5556.86107847303, 5570.693611851347, 5574.916376254359, 5581.134924086753, 5584.106542953128, 5457.317835270591, 5549.667019978794, 5758.107493338539, 5775.855603609902, 5792.855178620526, 5008.84973450797, 5017.598592112622, 5038.874028149289, 5040.6471546991725, 5040.941402305521, 18476.722849157275, 18744.15651295695, 18967.33614323492, 19401.32095376669, 19413.902930485398, 1851.8240767127102, 1974.141248556868, 1975.3777560068677, 1981.4154824326858, 2003.1386503803358, 8283.62723677436, 8503.95748021262, 8632.266257368132, 8664.350173736932, 8742.86885696715, 1684.553593297777, 1686.6036481426854, 1722.3110755697696, 1732.956676083108, 1817.1368599914936, 48270.27594586084, 49704.75147624239, 54797.0, 55810.0, 58313.708431458, 9688.806223875483, 9928.702138935843, 10110.443925584164, 10121.279382504992, 10200.897991019994, 12110.091743119301, 12337.198082124632, 12337.198082124813, 12337.50649974009, 12340.691482712824, 6327.3988971047675, 6409.455196308273, 6409.519286053564, 6770.661466926733, 6837.247902730695, 6126.0, 6224.315325314212, 6233.719482623293, 6238.189035425366, 6243.43809057178, 4062.959370406258, 4170.52039015511, 4212.347086201644, 4246.639035682002, 4281.721688090264, 1648.4751604765545, 1688.50189194188, 1714.6056407026454, 1721.7675613792228, 1766.6025144342677, 805.6555423716956, 820.7742870710603, 851.7061613743249, 857.3312816003527, 857.6055014693186, 14946.32741526634, 15235.619109522351, 15466.0, 15789.526314210592, 16731.07979061139, 780.5199802121655, 804.8511025460308, 833.2084519706303, 834.2116699718829, 853.8249658819927, 8391.916080839113, 8683.305335573139, 8709.738707838775, 8892.555372231363, 8927.419717718327, 470015.0, 472278.0, 482398.0, 482553.0, 493307.0, 72979.63510182415, 75087.24912750912, 75253.62373188099, 76499.0, 77231.61384193043, 1037.2842738510403, 1058.349115294104, 1063.2291588598205, 1066.1364294920984, 1066.7493139112457, 14139.151650900567, 14668.706625867637, 14720.263986800403, 14908.478203262834, 15017.6996460068, 19676.606467870275, 30669.693303066684, 31310.0, 31517.212069698442, 32416.189595260308, 39886.0, 40116.59883401129, 40316.0, 40643.0, 42787.47586536361, 8718.694845680371, 8951.641934322553, 8956.552172391224, 8959.641614335615, 8986.14631609996, 16845.747313790056, 16886.40897568579, 16978.830211697725, 17162.485125446256, 17255.56861078483, 13182.868171318547, 13816.516421925184, 14140.78788818148, 14247.786283205967, 14373.496927607484, 2225.6661500775012, 2249.9437514061624, 5222.947770522246, 12752.617421477371, 13589.158245457947, 11267.492962816528, 12297.954673852822, 13925.164490130624, 14038.438462461387, 14048.227347495986, 8074.798130046795, 8088.63601137962, 9014.639414423349, 9042.819143617222, 9304.302177336862, 13904.791428128789, 14071.859281407054, 14392.496262630757, 14406.927965360106, 14528.709425811636], "unit": "score", "name": "jquery.html", "value": 8055.293980386761}, {"lowerIsBetter": false, "replicates": [1427.6930459951122, 1670.31517077998, 1709.3675340124155, 1718.063655307858, 1743.4072415378773, 6317.810465686031, 6749.561278516899, 7105.396041336479, 7106.289371062891, 7107.0760801095785, 7149.1778445478785, 7268.636568171583, 7273.7090516379285, 7326.780196594097, 7337.376323012537, 2050.6411378008825, 2082.760482544504, 2085.5411809401908, 2085.8539902206853, 2087.5720477302116, 2064.8657837240607, 2066.1838573763353, 2066.3387715930908, 2122.8832414217213, 2126.617208902397, 1993.9700904486444, 2015.4961259685078, 2036.7657719362242, 2040.010594861491, 2040.2858999350258, 2047.948801279965, 2070.4616799632054, 2073.1810934680716, 2073.284716772711, 2073.3054426767053, 2026.432598872318, 2039.3576023552534, 2039.6022775558624, 2040.0615716770303, 2079.2618620389844, 7241.167265764452, 7308.0499535060635, 7319.560826350383, 7328.78013659591, 7329.596872172028, 4154.3976123462235, 4225.7887105644595, 4226.450561427026, 4229.450171477688, 4233.1322078973735, 2615.1500762252344, 2625.7899368050703, 2638.93402664933, 2658.840469571832, 2670.772984296337, 858.6007506509441, 863.2144748279098, 876.071364353787, 889.2530274569393, 894.9284057275468, 9619.663311784054, 9627.903720962771, 9641.855372169422, 9643.614255429775, 9661.275404344631, 3701.481792549045, 3718.1262403335195, 3772.3775577029483, 3774.9622503774613, 3858.3247931611854, 8497.532635704973, 8532.488050716976, 8543.572821359032, 8573.399862009599, 8579.099194584478, 4242.087951090531, 4248.9787551062045, 4257.3613957905945, 4263.531011588722, 4265.829366825292, 3105.223694076481, 3162.098801841464, 3693.649103335179, 3842.4620553122586, 3850.4801851749653, 3460.2906404187584, 3475.8609655614, 3497.0557949353533, 3513.771604845728, 3517.1734642359024, 1093.0654290581597, 1097.4896673047072, 1101.432762127505, 1104.2380757277454, 1121.4448847820381, 946.1531928923575, 955.7323949294208, 1190.2798806721983, 1193.7672153930073, 1223.853137623491, 6891.689873955684, 6906.861862762717, 6910.652422777611, 6925.168979722465, 6958.965205174043, 1084.1110289562641, 1131.1290306463977, 1135.3188087147646, 1152.1819508149308, 1163.336897968167, 5315.096433606296, 5370.0333939890415, 5372.0, 5381.730913454312, 5383.434739352311, 8463.619137138843, 8823.779405514784, 8894.110588941054, 8904.065073167354, 9006.189442950166, 8712.128787121237, 8721.127887211354, 8797.29621630268, 8800.823983520293, 8896.466212027299, 6919.204291506541, 6953.513254072268, 6975.3024697530855, 6976.058232138596, 6989.30106989297, 6652.501062420241, 6688.0, 6698.162729658793, 6711.194656641234, 6736.730530778714, 7900.170482099296, 7951.483153594998, 8082.7171049013, 8088.029436467662, 8149.0, 8020.799480013046, 8127.1466496017065, 8161.0, 8293.046299675374, 8296.419250652638, 5225.895482090261, 5586.77652893896, 5772.509336706259, 5774.566907481872, 5888.969430349586, 6921.6193109379465, 6936.930630693831, 6945.479089068441, 6965.373116419547, 6976.930230697628, 6401.775937842153, 6477.8704425912165, 6547.803565893031, 6578.0790689304495, 6643.302453242533, 6379.4896408286295, 6530.183727034121, 6550.47596192313, 6606.8678626426245, 6614.371634694697, 6572.638504882278, 6577.473802095725, 6606.4384527315715, 6607.47140228771, 6619.3380661933425, 5811.215485909348, 5971.552133589911, 5979.820605381846, 6068.059450785136, 6118.908216376847, 5990.910136348046, 6050.546209034252, 6057.091436284592, 6064.02975523914, 6068.332483426731], "unit": "score", "name": "mootools.html", "value": 4147.498895679128}, {"lowerIsBetter": false, "replicates": [298.8177211900741, 305.46391083648194, 309.18221304649205, 309.58051839757127, 310.7219038960132, 5224.973875130624, 5278.524932756051, 5354.384245811732, 5383.192521121834, 5389.703566303851, 5217.373915130181, 5301.946980530193, 5303.920441193375, 5305.7877684892555, 5312.946870531294, 3830.444585535096, 3898.8440462381473, 4097.180563887235, 4099.959000410003, 4107.240160570296, 3993.2013597280516, 4069.6540794032544, 4096.918061638766, 4098.159877225176, 4110.568390319018, 4055.3916912463073, 4062.3297155969376, 4065.125997910449, 4066.8983275418204, 4071.084006098619, 3823.4073718573663, 3934.0, 3942.960570394288, 4063.2889244382113, 4065.613766692189, 3553.0406790166767, 3553.3959226931483, 3555.5555555555557, 3556.3598552260582, 3560.287942411528, 5079.466656001104, 5081.974590127063, 5092.363454568179, 5105.183170692709, 5110.361204849394, 4647.047355292157, 4659.813607455698, 4660.627149828006, 4661.650376221797, 4663.766811659438, 5338.759755810997, 5512.503874651261, 5516.7517461714315, 5518.972405137949, 5533.280673512458, 3814.8664796731982, 3814.923701525954, 3825.6748176404762, 3829.4064420014943, 3833.674137698271, 5720.199172115866, 5815.621984571032, 5825.883482330372, 5827.271591051076, 5829.300483941955, 3894.045958740127, 3927.0378757204667, 3939.1530820873077, 3940.310445671996, 3940.566537680853, 3918.4122381642983, 3971.801409929492, 3989.261986532501, 3995.4006898965386, 4056.0468289951837, 4624.6993945394115, 4625.329327247598, 4629.074185162981, 4632.420947381577, 4634.745089020069, 5513.58648101386, 5515.034868897927, 5524.14375771756, 5525.475079867406, 5526.613137080366, 1387.6322774464775, 1412.7033323002079, 1413.1803553938691, 1413.9010269281257, 1414.1232435889608, 913.456493386434, 921.3783740616564, 962.4273557233435, 977.008336538414, 981.0679854138597, 4843.176659967814, 4849.927251091236, 4850.878728031827, 4851.56335929768, 4851.830185943475, 5734.5125664319, 5742.13867919807, 5742.942570574324, 5746.655200687972, 5750.137479378127, 4840.2255639097575, 4845.370101886802, 4846.927296090562, 4851.272309153655, 4852.975735121302, 2856.3858770364473, 2956.2904902823166, 3059.9541006884915, 3063.417950589381, 3095.272610936428, 5411.783528658888, 5415.539679127318, 5416.83749487516, 5420.972895135578, 5428.9185662215095, 5927.051671732502, 5937.287525496968, 5941.316748573883, 5941.940580594225, 5949.077892926603, 5481.561475082063, 5482.862928426821, 5491.560675145979, 5495.670259784506, 5496.203050557567, 5660.0, 5780.306363236438, 5787.276590426197, 5789.507891829242, 5790.218320526675, 5626.718664066699, 5632.605717599728, 5641.661500309994, 5642.520385767256, 5644.576656750678, 5471.671699698031, 5476.890462190813, 5481.287432633732, 5483.533899618577, 5486.835394938158, 3900.6099390060767, 3968.1270120573427, 3980.661643760313, 3981.144054028398, 3982.522097348221, 5740.339860915881, 5775.27809023872, 5779.190913272229, 5780.479756821906, 5783.450572195635, 5552.750126244409, 5557.499825015768, 5559.16612508127, 5566.638168519034, 5570.080936645408, 5550.916736248879, 5551.7779288828, 5559.471850174227, 5562.0, 5568.192612071146, 5312.229726689686, 5436.809711660073, 5456.072467680425, 5456.154296084113, 5461.863453413696, 5582.748776305158, 5599.188117722989, 5599.216109744721, 5604.635698679573, 5607.691576963306, 5465.781368745205, 5472.0, 5474.39781624029, 5478.315210598676, 5482.91775623358], "unit": "score", "name": "prototype.html", "value": 4156.697995619649}, {"lowerIsBetter": false, "replicates": [711.4770643576967, 726.4116065986548, 740.411372958498, 741.6773703439004, 766.9041369828772, 8319.417640765141, 8368.91631083689, 8372.706955256568, 8401.957990210056, 8403.159684031609, 9893.356931799446, 10787.946060269687, 10880.891191088087, 10920.50857711403, 10931.836022459649, 615.2463232540125, 784.8940393046951, 797.0913158998746, 801.9719309824158, 801.9879701804477, 784.9843003139933, 796.0606484348466, 797.2067792546425, 799.3046049936563, 800.131856935226, 653.3335997282769, 657.7434800427814, 665.6538599928034, 831.0235473318857, 840.2437805974641, 813.3452570680599, 820.4420993724295, 826.7189155687096, 827.3463963468853, 827.6606591297539, 615.1603061820628, 617.1452538234578, 617.1483352972914, 617.2469587103726, 618.4526693875907, 10621.203409744223, 10818.945905270502, 10821.0, 10841.13270938323, 10847.023767860852, 10386.688399347957, 10813.891861081367, 11016.11871050322, 11097.722556936142, 11218.158638102175, 8627.611757470866, 8639.65441382344, 8783.956080219621, 8873.334499912533, 8883.644654213824, 3115.2990577120195, 3187.42626327261, 3195.3928753536984, 3215.887443939451, 3216.453202955503, 37478.25043499142, 37509.437358439645, 37524.24951500982, 37577.81211093927, 37628.81185594082, 8382.622781974826, 8525.74422767318, 8660.69687560945, 8730.0, 8753.693620723245, 15753.212339382984, 15766.369345226292, 15771.921140394224, 15782.605434864221, 15796.842031579767, 5791.536677065825, 5848.619839710405, 5905.586608937419, 6024.0, 6168.691565421711, 3427.1946092668204, 3438.4670376091744, 3494.2487365216093, 3550.3254381667402, 3551.058969373118, 2442.694663167104, 2484.3292311075907, 2485.453200295932, 2486.0, 2486.3411196033067, 413.32215167125935, 424.3189680562714, 429.63910315335266, 435.03639438642927, 438.8507907311529, 510.43086958041516, 537.8467136866053, 547.4580165635991, 556.8246002509196, 560.330405165823, 6937.7224911002995, 6960.651967401711, 7022.789316320519, 7058.858822823515, 7094.11323584552, 523.8035736598775, 539.5467807042104, 543.5977376741183, 554.1493807006226, 565.8787968881686, 3049.2224482757197, 3175.491921292582, 3208.342289830579, 3254.9674503255137, 3318.3197444523817, 51127.48872511302, 55040.44959550353, 55111.0, 55421.445785541626, 55645.0, 41192.588074118874, 41720.79139604283, 43445.56554434415, 43604.345934811005, 43687.0, 38147.23705525874, 38490.23019539593, 38878.61121388806, 38927.61072389296, 39126.99999999943, 6970.163580370388, 6976.6860491277, 7099.609521476368, 7124.3944264738075, 7248.879528054028, 29238.561421579117, 29893.850530747208, 30150.0, 30200.64097115591, 30680.846595766878, 34198.0, 34218.31563368669, 34468.65531344755, 34668.13329666779, 37866.62133378631, 8122.593870306579, 8138.959305203436, 8751.606177722146, 9348.579313930753, 9654.75863103428, 8585.098564650621, 8662.307015438875, 8663.870041949249, 8674.653013879626, 8680.956595216983, 9782.315237933277, 9889.307748457539, 9915.30592858493, 9957.651482198089, 10065.899341006496, 9483.857742134012, 9490.478023708762, 9519.476428796206, 9519.762005949906, 9549.28380371461, 9440.858387124335, 9516.809663806824, 9656.32405731592, 9834.508274586386, 9857.30998830075, 7898.921010789819, 8592.140785921358, 8641.438306510057, 8720.65971706608, 8740.694075707319, 8348.165183481604, 8547.658093676184, 8643.092475290256, 8682.446898557146, 8801.691940782042], "unit": "score", "name": "yui.html", "value": 5308.376913994241}], "name": "dromaeo_css", "value": 6249.930692882857}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 113.0, 102.0, 112.0, 113.0, 105.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 163.0, 170.0, 138.0, 149.0, 147.0, 130.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 106.0, 75.0, 71.0, 71.0, 100.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 129.0, 94.0, 95.0, 95.0, 132.0, 94.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 149.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 71.0, 75.0, 72.0, 81.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 92.0, 89.0, 83.0, 82.0, 83.0, 83.0, 92.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 128.0, 118.0, 120.0, 124.0, 126.0, 123.0, 117.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [134.0, 148.0, 148.0, 149.0, 145.0, 136.0, 141.0, 147.0, 150.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 69.0, 70.0, 69.0, 70.0, 70.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [186.3238308179616], "unit": "score", "name": "DeltaBlue", "value": 354.85530600000016}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [27594.594594594593], "unit": "score", "name": "RegExp", "value": 33.01316846229187}, {"lowerIsBetter": false, "replicates": [598.5748218527316], "unit": "score", "name": "Splay", "value": 136.14171031746028}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19802.53054202755}]} 05:44:54 INFO - RETURN: dromaeo_css: 6249.93 05:44:54 INFO - RETURN: kraken: 1521.80 05:44:54 INFO - RETURN: v8_7: 19802.53 05:44:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19802.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6249.93"}}} 05:44:54 INFO - Return code: 0 05:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:44:54 INFO - # TBPL SUCCESS # 05:44:54 INFO - Running post-action listener: _resource_record_post_action 05:44:54 INFO - Running post-run listener: _resource_record_post_run 05:44:55 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547467264; Read time: 16; Write time: 451804 05:44:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 226672640; Read time: 0; Write time: 275236 05:44:55 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319930368; Read time: 16; Write time: 176524 05:44:55 INFO - Running post-run listener: _upload_blobber_files 05:44:55 INFO - Blob upload gear active. 05:44:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:44:55 INFO - Copying logs to upload dir... 05:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.972449 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-18 05:44:54.730064) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:44:54.733192) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009876 build_url: 'https://queue.taskcluster.net/v1/task/aR4Uu3cyTCWVwuPeM-QT2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:44:54.784833) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:44:54.785196) ========= 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=919420d7ee4ef147bef0346300000385-1450444299.380615-974832600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:44:54.836478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:44:54.837121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:44:54.837712) ========= ========= Total master_lag: 0.33 =========