builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1450607553.58 results: success (0) buildid: 20151220014831 builduid: 638c7ba2cd204203be8c25b769dc95bf revision: a8e74b6b0511c38b87b6414e99eaa40c75c65205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.576017) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.576819) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.577177) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.657097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.657484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.713689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.714056) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.770021) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.770387) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.770808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.771134) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 02:32:35-- 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% 78.4M=0s 2015-12-20 02:32:35 (78.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105302 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.897972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.898295) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.952591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:33.953184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a8e74b6b0511c38b87b6414e99eaa40c75c65205 --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 a8e74b6b0511c38b87b6414e99eaa40c75c65205 --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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 02:32:35,472 truncating revision to first 12 chars 2015-12-20 02:32:35,472 Setting DEBUG logging. 2015-12-20 02:32:35,472 attempt 1/10 2015-12-20 02:32:35,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a8e74b6b0511?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 02:32:35,831 unpacking tar archive at: fx-team-a8e74b6b0511/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.592793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.593166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.602538) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.602957) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 02:32:34.603480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-20 02:32:34.603814) ========= /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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:36 INFO - MultiFileLogger online at 20151220 02:32:36 in /builds/slave/test 02:32: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 02:32:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:36 INFO - {'append_to_log': False, 02:32:36 INFO - 'base_work_dir': '/builds/slave/test', 02:32:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:32:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:36 INFO - 'branch': 'Fx-Team-Non-PGO', 02:32:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:36 INFO - 'config_files': ('talos/linux_config.py',), 02:32:36 INFO - 'default_actions': ('clobber', 02:32:36 INFO - 'read-buildbot-config', 02:32:36 INFO - 'download-and-extract', 02:32:36 INFO - 'populate-webroot', 02:32:36 INFO - 'create-virtualenv', 02:32:36 INFO - 'install', 02:32:36 INFO - 'run-tests'), 02:32:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:36 INFO - 'download_minidump_stackwalk': True, 02:32:36 INFO - 'download_symbols': 'ondemand', 02:32:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:36 INFO - 'installer_path': 'installer.exe', 02:32:36 INFO - 'log_level': 'info', 02:32:36 INFO - 'log_name': 'talos', 02:32:36 INFO - 'log_to_console': True, 02:32:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:36 INFO - 'opt_config_files': (), 02:32:36 INFO - 'pip_index': False, 02:32:36 INFO - 'sps_profile': False, 02:32:36 INFO - 'sps_profile_interval': 0, 02:32:36 INFO - 'suite': 'dromaeojs', 02:32:36 INFO - 'system_bits': '64', 02:32:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:36 INFO - 'title': 'talos-linux64-ix-051', 02:32:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:36 INFO - 'use_talos_json': True, 02:32:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:36 INFO - 'work_dir': 'build'} 02:32:36 INFO - ##### 02:32:36 INFO - ##### Running clobber step. 02:32:36 INFO - ##### 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: clobber 02:32:36 INFO - rmtree: /builds/slave/test/build 02:32:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:37 INFO - Running post-action listener: _resource_record_post_action 02:32:37 INFO - ##### 02:32:37 INFO - ##### Running read-buildbot-config step. 02:32:37 INFO - ##### 02:32:37 INFO - Running pre-action listener: _resource_record_pre_action 02:32:37 INFO - Running main action method: read_buildbot_config 02:32:37 INFO - Using buildbot properties: 02:32:37 INFO - { 02:32:37 INFO - "project": "", 02:32:37 INFO - "product": "firefox", 02:32:37 INFO - "script_repo_revision": "production", 02:32:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:32:37 INFO - "repository": "", 02:32:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:32:37 INFO - "buildid": "20151220014831", 02:32:37 INFO - "pgo_build": "False", 02:32:37 INFO - "basedir": "/builds/slave/test", 02:32:37 INFO - "buildnumber": 1031, 02:32:37 INFO - "slavename": "talos-linux64-ix-051", 02:32:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:32:37 INFO - "platform": "ubuntu64_hw", 02:32:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:32:37 INFO - "branch": "fx-team", 02:32:37 INFO - "repo_path": "integration/fx-team", 02:32:37 INFO - "revision": "a8e74b6b0511c38b87b6414e99eaa40c75c65205", 02:32:37 INFO - "stage_platform": "linux64", 02:32:37 INFO - "builduid": "638c7ba2cd204203be8c25b769dc95bf", 02:32:37 INFO - "slavebuilddir": "test" 02:32:37 INFO - } 02:32:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:32:37 INFO - Running post-action listener: _resource_record_post_action 02:32:37 INFO - ##### 02:32:37 INFO - ##### Running download-and-extract step. 02:32:37 INFO - ##### 02:32:37 INFO - Running pre-action listener: _resource_record_pre_action 02:32:37 INFO - Running main action method: download_and_extract 02:32:37 INFO - mkdir: /builds/slave/test/build/tests 02:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:37 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json 02:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json 02:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:32:43 INFO - Downloaded 1302 bytes. 02:32:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:32:43 INFO - Using the following test package requirements: 02:32:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'jsshell-linux-x86_64.zip'], 02:32:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:32:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:32:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:43 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:45 INFO - Downloaded 21872076 bytes. 02:32:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:32:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:32:46 INFO - Return code: 0 02:32:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:46 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:49 INFO - Downloaded 21872076 bytes. 02:32:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:32:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:32:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:32:51 INFO - Return code: 0 02:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:51 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:52 INFO - Downloaded 11132039 bytes. 02:32:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:32:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:32:52 INFO - Return code: 0 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:32:53 INFO - Downloaded 53059792 bytes. 02:32:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:32:53 INFO - mkdir: /builds/slave/test/properties 02:32:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:53 INFO - Contents: 02:32:53 INFO - build_url:https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:32:53 INFO - Running post-action listener: _resource_record_post_action 02:32:53 INFO - Running post-action listener: set_extra_try_arguments 02:32:53 INFO - ##### 02:32:53 INFO - ##### Running populate-webroot step. 02:32:53 INFO - ##### 02:32:53 INFO - Running pre-action listener: _resource_record_pre_action 02:32:53 INFO - Running main action method: populate_webroot 02:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:53 INFO - '--tppagecycles', 02:32:53 INFO - '7'], 02:32:53 INFO - 'tests': ['tsvgm']}}, 02:32:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:32:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['damp', 'tps']}, 02:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['damp', 'tps']}, 02:32:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:53 INFO - 'other': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other_l64': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'other_nol64': {'tests': ['a11yr', 02:32:53 INFO - 'ts_paint', 02:32:53 INFO - 'tpaint', 02:32:53 INFO - 'sessionrestore', 02:32:53 INFO - 'sessionrestore_no_auto_restore']}, 02:32:53 INFO - 'svgr': {'tests': ['tsvgx', 02:32:53 INFO - 'tsvgr_opacity', 02:32:53 INFO - 'tart', 02:32:53 INFO - 'tscrollx', 02:32:53 INFO - 'cart']}, 02:32:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tsvgx', 02:32:53 INFO - 'tsvgr_opacity', 02:32:53 INFO - 'tart', 02:32:53 INFO - 'tscrollx', 02:32:53 INFO - 'cart']}, 02:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'tests': ['tp5o']}, 02:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s'], 02:32:53 INFO - 'tests': ['tp5o']}, 02:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--xperf_path', 02:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:53 INFO - 'tests': ['tp5n']}, 02:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:53 INFO - 'talos_options': ['--e10s', 02:32:53 INFO - '--xperf_path', 02:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:53 INFO - 'tests': ['tp5n']}}, 02:32:53 INFO - 'talos.zip': {'path': '', 02:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:53 INFO - Running post-action listener: _resource_record_post_action 02:32:53 INFO - ##### 02:32:53 INFO - ##### Running create-virtualenv step. 02:32:53 INFO - ##### 02:32:53 INFO - Running pre-action listener: _resource_record_pre_action 02:32:53 INFO - Running main action method: create_virtualenv 02:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:53 INFO - Using real prefix '/usr' 02:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:56 INFO - Installing pip.................done. 02:32:56 INFO - Return code: 0 02:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:32:56 INFO - Using env: {'DISPLAY': ':0', 02:32:56 INFO - 'HOME': '/home/cltbld', 02:32:56 INFO - 'LANG': 'en_US.UTF-8', 02:32:56 INFO - 'LANGUAGE': 'en_US:en', 02:32:56 INFO - 'LOGNAME': 'cltbld', 02:32:56 INFO - 'MAIL': '/var/mail/cltbld', 02:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:56 INFO - 'MOZ_NO_REMOTE': '1', 02:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:56 INFO - 'NO_EM_RESTART': '1', 02:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:56 INFO - 'PWD': '/builds/slave/test', 02:32:56 INFO - 'SHELL': '/bin/bash', 02:32:56 INFO - 'SHLVL': '1', 02:32:56 INFO - 'TERM': 'linux', 02:32:56 INFO - 'TMOUT': '86400', 02:32:56 INFO - 'USER': 'cltbld', 02:32:56 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:56 INFO - '_': '/tools/buildbot/bin/python'} 02:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:32:56 INFO - Cleaning up... 02:32:56 INFO - Return code: 0 02:32:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:32:56 INFO - Using env: {'DISPLAY': ':0', 02:32:56 INFO - 'HOME': '/home/cltbld', 02:32:56 INFO - 'LANG': 'en_US.UTF-8', 02:32:56 INFO - 'LANGUAGE': 'en_US:en', 02:32:56 INFO - 'LOGNAME': 'cltbld', 02:32:56 INFO - 'MAIL': '/var/mail/cltbld', 02:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:56 INFO - 'MOZ_NO_REMOTE': '1', 02:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:56 INFO - 'NO_EM_RESTART': '1', 02:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:56 INFO - 'PWD': '/builds/slave/test', 02:32:56 INFO - 'SHELL': '/bin/bash', 02:32:56 INFO - 'SHLVL': '1', 02:32:56 INFO - 'TERM': 'linux', 02:32:56 INFO - 'TMOUT': '86400', 02:32:56 INFO - 'USER': 'cltbld', 02:32:56 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:56 INFO - '_': '/tools/buildbot/bin/python'} 02:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:56 INFO - Downloading/unpacking psutil>=0.7.1 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:58 INFO - Installing collected packages: psutil 02:32:58 INFO - Running setup.py install for psutil 02:32:58 INFO - building 'psutil._psutil_linux' extension 02:32:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:32:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:32:59 INFO - building 'psutil._psutil_posix' extension 02:32:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:32:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:59 INFO - Successfully installed psutil 02:32:59 INFO - Cleaning up... 02:32:59 INFO - Return code: 0 02:32:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:32:59 INFO - Using env: {'DISPLAY': ':0', 02:32:59 INFO - 'HOME': '/home/cltbld', 02:32:59 INFO - 'LANG': 'en_US.UTF-8', 02:32:59 INFO - 'LANGUAGE': 'en_US:en', 02:32:59 INFO - 'LOGNAME': 'cltbld', 02:32:59 INFO - 'MAIL': '/var/mail/cltbld', 02:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:59 INFO - 'MOZ_NO_REMOTE': '1', 02:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:59 INFO - 'NO_EM_RESTART': '1', 02:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:59 INFO - 'PWD': '/builds/slave/test', 02:32:59 INFO - 'SHELL': '/bin/bash', 02:32:59 INFO - 'SHLVL': '1', 02:32:59 INFO - 'TERM': 'linux', 02:32:59 INFO - 'TMOUT': '86400', 02:32:59 INFO - 'USER': 'cltbld', 02:32:59 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:59 INFO - '_': '/tools/buildbot/bin/python'} 02:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:01 INFO - Installing collected packages: mozsystemmonitor 02:33:01 INFO - Running setup.py install for mozsystemmonitor 02:33:01 INFO - Successfully installed mozsystemmonitor 02:33:01 INFO - Cleaning up... 02:33:01 INFO - Return code: 0 02:33:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:01 INFO - Using env: {'DISPLAY': ':0', 02:33:01 INFO - 'HOME': '/home/cltbld', 02:33:01 INFO - 'LANG': 'en_US.UTF-8', 02:33:01 INFO - 'LANGUAGE': 'en_US:en', 02:33:01 INFO - 'LOGNAME': 'cltbld', 02:33:01 INFO - 'MAIL': '/var/mail/cltbld', 02:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:01 INFO - 'MOZ_NO_REMOTE': '1', 02:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:01 INFO - 'NO_EM_RESTART': '1', 02:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:01 INFO - 'PWD': '/builds/slave/test', 02:33:01 INFO - 'SHELL': '/bin/bash', 02:33:01 INFO - 'SHLVL': '1', 02:33:01 INFO - 'TERM': 'linux', 02:33:01 INFO - 'TMOUT': '86400', 02:33:01 INFO - 'USER': 'cltbld', 02:33:01 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:01 INFO - '_': '/tools/buildbot/bin/python'} 02:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:03 INFO - Downloading docopt-0.6.1.tar.gz 02:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:03 INFO - Running setup.py install for blobuploader 02:33:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:04 INFO - Running setup.py install for requests 02:33:04 INFO - Running setup.py install for docopt 02:33:04 INFO - Successfully installed blobuploader requests docopt 02:33:04 INFO - Cleaning up... 02:33:04 INFO - Return code: 0 02:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:04 INFO - Using env: {'DISPLAY': ':0', 02:33:04 INFO - 'HOME': '/home/cltbld', 02:33:04 INFO - 'LANG': 'en_US.UTF-8', 02:33:04 INFO - 'LANGUAGE': 'en_US:en', 02:33:04 INFO - 'LOGNAME': 'cltbld', 02:33:04 INFO - 'MAIL': '/var/mail/cltbld', 02:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:04 INFO - 'MOZ_NO_REMOTE': '1', 02:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:04 INFO - 'NO_EM_RESTART': '1', 02:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:04 INFO - 'PWD': '/builds/slave/test', 02:33:04 INFO - 'SHELL': '/bin/bash', 02:33:04 INFO - 'SHLVL': '1', 02:33:04 INFO - 'TERM': 'linux', 02:33:04 INFO - 'TMOUT': '86400', 02:33:04 INFO - 'USER': 'cltbld', 02:33:04 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:04 INFO - '_': '/tools/buildbot/bin/python'} 02:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:04 INFO - Running setup.py (path:/tmp/pip-U8EO56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:04 INFO - Running setup.py (path:/tmp/pip-ZhV0q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:04 INFO - Running setup.py (path:/tmp/pip-0oqbAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:05 INFO - Running setup.py (path:/tmp/pip-kIO9r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:05 INFO - Running setup.py (path:/tmp/pip-hBO0VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:05 INFO - Running setup.py (path:/tmp/pip-KI9Fnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:05 INFO - Running setup.py (path:/tmp/pip-mLBOV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:05 INFO - Running setup.py (path:/tmp/pip-EVSCL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:05 INFO - Running setup.py (path:/tmp/pip-SSAH5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:05 INFO - Running setup.py (path:/tmp/pip-mLYlCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:05 INFO - Running setup.py (path:/tmp/pip-ewuiHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:05 INFO - Running setup.py (path:/tmp/pip-X9qWnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:05 INFO - Running setup.py (path:/tmp/pip-vc5vbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:05 INFO - Running setup.py (path:/tmp/pip-EhSm3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:05 INFO - Running setup.py (path:/tmp/pip-EZGW4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:05 INFO - Running setup.py (path:/tmp/pip-_25MGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:05 INFO - Running setup.py (path:/tmp/pip-iu0JxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:05 INFO - Running setup.py install for manifestparser 02:33:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Running setup.py install for mozcrash 02:33:06 INFO - Running setup.py install for mozdebug 02:33:06 INFO - Running setup.py install for mozdevice 02:33:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Running setup.py install for mozfile 02:33:06 INFO - Running setup.py install for mozhttpd 02:33:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Running setup.py install for mozinfo 02:33:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Running setup.py install for mozInstall 02:33:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:06 INFO - Running setup.py install for mozleak 02:33:06 INFO - Running setup.py install for mozlog 02:33:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Running setup.py install for moznetwork 02:33:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Running setup.py install for mozprocess 02:33:07 INFO - Running setup.py install for mozprofile 02:33:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Running setup.py install for mozrunner 02:33:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Running setup.py install for mozscreenshot 02:33:07 INFO - Running setup.py install for moztest 02:33:07 INFO - Running setup.py install for mozversion 02:33:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:07 INFO - Cleaning up... 02:33:07 INFO - Return code: 0 02:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:07 INFO - Using env: {'DISPLAY': ':0', 02:33:07 INFO - 'HOME': '/home/cltbld', 02:33:07 INFO - 'LANG': 'en_US.UTF-8', 02:33:07 INFO - 'LANGUAGE': 'en_US:en', 02:33:07 INFO - 'LOGNAME': 'cltbld', 02:33:07 INFO - 'MAIL': '/var/mail/cltbld', 02:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:07 INFO - 'MOZ_NO_REMOTE': '1', 02:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:07 INFO - 'NO_EM_RESTART': '1', 02:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:07 INFO - 'PWD': '/builds/slave/test', 02:33:07 INFO - 'SHELL': '/bin/bash', 02:33:07 INFO - 'SHLVL': '1', 02:33:07 INFO - 'TERM': 'linux', 02:33:07 INFO - 'TMOUT': '86400', 02:33:07 INFO - 'USER': 'cltbld', 02:33:07 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:07 INFO - '_': '/tools/buildbot/bin/python'} 02:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:07 INFO - Running setup.py (path:/tmp/pip-XHJlFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:08 INFO - Running setup.py (path:/tmp/pip-VqBCW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:08 INFO - Running setup.py (path:/tmp/pip-cWNUY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:08 INFO - Running setup.py (path:/tmp/pip-dZBxOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:08 INFO - Running setup.py (path:/tmp/pip-ZGXRs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:08 INFO - Running setup.py (path:/tmp/pip-wfdpoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:08 INFO - Running setup.py (path:/tmp/pip-Rj7JBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:08 INFO - Running setup.py (path:/tmp/pip-RYPEtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:08 INFO - Running setup.py (path:/tmp/pip-p_irUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:08 INFO - Running setup.py (path:/tmp/pip-OawHBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:08 INFO - Running setup.py (path:/tmp/pip-GcJjG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:08 INFO - Running setup.py (path:/tmp/pip-HaQEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:08 INFO - Running setup.py (path:/tmp/pip-0ELdyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:08 INFO - Running setup.py (path:/tmp/pip-yxuUy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:09 INFO - Running setup.py (path:/tmp/pip-prhMvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:09 INFO - Running setup.py (path:/tmp/pip-z2fudb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:09 INFO - Running setup.py (path:/tmp/pip-ZCawDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:10 INFO - Downloading blessings-1.5.1.tar.gz 02:33:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:10 INFO - Installing collected packages: blessings 02:33:10 INFO - Running setup.py install for blessings 02:33:11 INFO - Successfully installed blessings 02:33:11 INFO - Cleaning up... 02:33:11 INFO - Return code: 0 02:33:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:11 INFO - Reading from file tmpfile_stdout 02:33:11 INFO - Current package versions: 02:33:11 INFO - argparse == 1.2.1 02:33:11 INFO - blessings == 1.5.1 02:33:11 INFO - blobuploader == 1.2.4 02:33:11 INFO - docopt == 0.6.1 02:33:11 INFO - manifestparser == 1.1 02:33:11 INFO - mozInstall == 1.12 02:33:11 INFO - mozcrash == 0.16 02:33:11 INFO - mozdebug == 0.1 02:33:11 INFO - mozdevice == 0.47 02:33:11 INFO - mozfile == 1.2 02:33:11 INFO - mozhttpd == 0.7 02:33:11 INFO - mozinfo == 0.9 02:33:11 INFO - mozleak == 0.1 02:33:11 INFO - mozlog == 3.1 02:33:11 INFO - moznetwork == 0.27 02:33:11 INFO - mozprocess == 0.22 02:33:11 INFO - mozprofile == 0.27 02:33:11 INFO - mozrunner == 6.11 02:33:11 INFO - mozscreenshot == 0.1 02:33:11 INFO - mozsystemmonitor == 0.0 02:33:11 INFO - moztest == 0.7 02:33:11 INFO - mozversion == 1.4 02:33:11 INFO - psutil == 3.1.1 02:33:11 INFO - requests == 1.2.3 02:33:11 INFO - wsgiref == 0.1.2 02:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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/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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33: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/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33: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/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:11 INFO - Using env: {'DISPLAY': ':0', 02:33:11 INFO - 'HOME': '/home/cltbld', 02:33:11 INFO - 'LANG': 'en_US.UTF-8', 02:33:11 INFO - 'LANGUAGE': 'en_US:en', 02:33:11 INFO - 'LOGNAME': 'cltbld', 02:33:11 INFO - 'MAIL': '/var/mail/cltbld', 02:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:11 INFO - 'MOZ_NO_REMOTE': '1', 02:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:11 INFO - 'NO_EM_RESTART': '1', 02:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:11 INFO - 'PWD': '/builds/slave/test', 02:33:11 INFO - 'SHELL': '/bin/bash', 02:33:11 INFO - 'SHLVL': '1', 02:33:11 INFO - 'TERM': 'linux', 02:33:11 INFO - 'TMOUT': '86400', 02:33:11 INFO - 'USER': 'cltbld', 02:33:11 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:11 INFO - '_': '/tools/buildbot/bin/python'} 02:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:11 INFO - Cleaning up... 02:33:11 INFO - Return code: 0 02:33:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', '--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 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:33:11 INFO - Using env: {'DISPLAY': ':0', 02:33:11 INFO - 'HOME': '/home/cltbld', 02:33:11 INFO - 'LANG': 'en_US.UTF-8', 02:33:11 INFO - 'LANGUAGE': 'en_US:en', 02:33:11 INFO - 'LOGNAME': 'cltbld', 02:33:11 INFO - 'MAIL': '/var/mail/cltbld', 02:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:11 INFO - 'MOZ_NO_REMOTE': '1', 02:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:11 INFO - 'NO_EM_RESTART': '1', 02:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:11 INFO - 'PWD': '/builds/slave/test', 02:33:11 INFO - 'SHELL': '/bin/bash', 02:33:11 INFO - 'SHLVL': '1', 02:33:11 INFO - 'TERM': 'linux', 02:33:11 INFO - 'TMOUT': '86400', 02:33:11 INFO - 'USER': 'cltbld', 02:33:11 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:11 INFO - '_': '/tools/buildbot/bin/python'} 02:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:11 INFO - Downloading/unpacking jsonschema 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:33:13 INFO - Downloading/unpacking functools32 (from jsonschema) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:13 INFO - warning: no files found matching '*.txt' 02:33:13 INFO - no previously-included directories found matching 'build' 02:33:13 INFO - no previously-included directories found matching 'dist' 02:33:13 INFO - no previously-included directories found matching '.git*' 02:33:13 INFO - Installing collected packages: jsonschema, functools32 02:33:13 INFO - Running setup.py install for functools32 02:33:13 INFO - warning: no files found matching '*.txt' 02:33:13 INFO - no previously-included directories found matching 'build' 02:33:13 INFO - no previously-included directories found matching 'dist' 02:33:13 INFO - no previously-included directories found matching '.git*' 02:33:13 INFO - Successfully installed jsonschema functools32 02:33:13 INFO - Cleaning up... 02:33:13 INFO - Return code: 0 02:33:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02f08a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:33:13 INFO - Using env: {'DISPLAY': ':0', 02:33:13 INFO - 'HOME': '/home/cltbld', 02:33:13 INFO - 'LANG': 'en_US.UTF-8', 02:33:13 INFO - 'LANGUAGE': 'en_US:en', 02:33:13 INFO - 'LOGNAME': 'cltbld', 02:33:13 INFO - 'MAIL': '/var/mail/cltbld', 02:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:13 INFO - 'MOZ_NO_REMOTE': '1', 02:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:13 INFO - 'NO_EM_RESTART': '1', 02:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:13 INFO - 'PWD': '/builds/slave/test', 02:33:13 INFO - 'SHELL': '/bin/bash', 02:33:13 INFO - 'SHLVL': '1', 02:33:13 INFO - 'TERM': 'linux', 02:33:13 INFO - 'TMOUT': '86400', 02:33:13 INFO - 'USER': 'cltbld', 02:33:13 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:13 INFO - '_': '/tools/buildbot/bin/python'} 02:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:14 INFO - Downloading/unpacking flake8 02:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:33:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:33:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:33:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:33:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:33:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:33:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:16 INFO - no previously-included directories found matching 'docs/_build' 02:33:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:33:16 INFO - Running setup.py install for pep8 02:33:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:16 INFO - no previously-included directories found matching 'docs/_build' 02:33:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:33:16 INFO - Cleaning up... 02:33:16 INFO - Return code: 0 02:33:16 INFO - Running post-action listener: _resource_record_post_action 02:33:16 INFO - Running post-action listener: _start_resource_monitoring 02:33:16 INFO - Starting resource monitoring. 02:33:16 INFO - ##### 02:33:16 INFO - ##### Running install step. 02:33:16 INFO - ##### 02:33:16 INFO - Running pre-action listener: _resource_record_pre_action 02:33:16 INFO - Running main action method: install 02:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:16 INFO - Reading from file tmpfile_stdout 02:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:16 INFO - Reading from file tmpfile_stdout 02:33:16 INFO - Output received: 02:33:16 INFO - Usage: mozinstall [options] installer 02:33:16 INFO - Options: 02:33:16 INFO - -h, --help show this help message and exit 02:33:16 INFO - -d DEST, --destination=DEST 02:33:16 INFO - Directory to install application into. [default: 02:33:16 INFO - "/builds/slave/test"] 02:33:16 INFO - --app=APP Application being installed. [default: firefox] 02:33:16 INFO - mkdir: /builds/slave/test/build/application 02:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:33:32 INFO - Reading from file tmpfile_stdout 02:33:32 INFO - Output received: 02:33:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:32 INFO - Running post-action listener: _resource_record_post_action 02:33:32 INFO - ##### 02:33:32 INFO - ##### Running run-tests step. 02:33:32 INFO - ##### 02:33:32 INFO - Running pre-action listener: _resource_record_pre_action 02:33:32 INFO - Running main action method: run_tests 02:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:32 INFO - Python 2.7.3 02:33:32 INFO - Return code: 0 02:33:32 INFO - grabbing minidump binary from tooltool 02:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:32 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 0x29360b0>, '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 0x2936fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2937440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:33:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:33:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:32 INFO - Return code: 0 02:33:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:33:33 INFO - Return code: 0 02:33:33 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/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] in /builds/slave/test/build 02:33:33 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/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost 02:33:33 INFO - Using env: {'DISPLAY': ':0', 02:33:33 INFO - 'HOME': '/home/cltbld', 02:33:33 INFO - 'LANG': 'en_US.UTF-8', 02:33:33 INFO - 'LANGUAGE': 'en_US:en', 02:33:33 INFO - 'LOGNAME': 'cltbld', 02:33:33 INFO - 'MAIL': '/var/mail/cltbld', 02:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:33 INFO - 'MOZ_NO_REMOTE': '1', 02:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:33 INFO - 'NO_EM_RESTART': '1', 02:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:33 INFO - 'PWD': '/builds/slave/test', 02:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:33 INFO - 'SHELL': '/bin/bash', 02:33:33 INFO - 'SHLVL': '1', 02:33:33 INFO - 'TERM': 'linux', 02:33:33 INFO - 'TMOUT': '86400', 02:33:33 INFO - 'USER': 'cltbld', 02:33:33 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325', 02:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:33 INFO - '_': '/tools/buildbot/bin/python'} 02:33:33 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/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] with output_timeout 3600 02:33:33 INFO - mozversion INFO | application_buildid: 20151220014831 02:33:33 INFO - mozversion INFO | application_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 02:33:33 INFO - mozversion INFO | application_display_name: Nightly 02:33:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:33 INFO - mozversion INFO | application_name: Firefox 02:33:33 INFO - mozversion INFO | application_remotingname: firefox 02:33:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:33:33 INFO - mozversion INFO | application_vendor: Mozilla 02:33:33 INFO - mozversion INFO | application_version: 46.0a1 02:33:33 INFO - mozversion INFO | platform_buildid: 20151220014831 02:33:33 INFO - mozversion INFO | platform_changeset: a8e74b6b0511c38b87b6414e99eaa40c75c65205 02:33:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:33:33 INFO - mozversion INFO | platform_version: 46.0a1 02:33:33 INFO - 2015-12-20 02:33:33,602 DEBUG : using testdate: 1450607613 02:33:33 INFO - 2015-12-20 02:33:33,602 DEBUG : actual date: 1450607613 02:33:33 INFO - 2015-12-20 02:33:33,612 INFO : starting webserver on 'localhost:57727' 02:33:33 INFO - 2015-12-20 02:33:33,613 INFO : Starting test suite talos-linux64-ix-051 02:33:33 INFO - 2015-12-20 02:33:33,613 INFO : Starting test dromaeo_css 02:33:33 INFO - 2015-12-20 02:33:33,613 DEBUG : operating with platform_type : linux_ 02:33:33 INFO - 2015-12-20 02:33:33,614 INFO : Initialising browser for dromaeo_css test... 02:33:33 INFO - 2015-12-20 02:33:33,627 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXS5q8D/profile http://localhost:57727/getInfo.html 02:33:37 INFO - 2015-12-20 02:33:37,863 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:33:37 INFO - 2015-12-20 02:33:37,871 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:33:37 INFO - 2015-12-20 02:33:37,871 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:33:37 INFO - 2015-12-20 02:33:37,872 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:33:37 INFO - 2015-12-20 02:33:37,872 DEBUG : BROWSER_OUTPUT: __metrics 02:33:37 INFO - 2015-12-20 02:33:37,989 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:33:38 INFO - 2015-12-20 02:33:38,045 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:39 INFO - 2015-12-20 02:33:39,147 INFO : Browser initialized. 02:33:39 INFO - 2015-12-20 02:33:39,147 INFO : Running cycle 1/1 for dromaeo_css test... 02:33:39 INFO - 2015-12-20 02:33:39,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXS5q8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:33:51 INFO - 2015-12-20 02:33:51,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 149630976 02:33:51 INFO - 2015-12-20 02:33:51,120 DEBUG : BROWSER_OUTPUT: 02:34:42 INFO - 2015-12-20 02:34:42,573 DEBUG : BROWSER_OUTPUT: 1450607682572 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:36:54 INFO - 2015-12-20 02:36:54,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57727/tests/dromaeo/cssquery-ext.html) 02:36:55 INFO - 2015-12-20 02:36:55,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 254382080 02:36:55 INFO - 2015-12-20 02:36:55,933 DEBUG : BROWSER_OUTPUT: 02:39:58 INFO - 2015-12-20 02:39:58,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-ext.html (next: http://localhost:57727/tests/dromaeo/cssquery-jquery.html) 02:39:58 INFO - 2015-12-20 02:39:58,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 232005632 02:39:58 INFO - 2015-12-20 02:39:58,978 DEBUG : BROWSER_OUTPUT: 02:43:01 INFO - 2015-12-20 02:43:01,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57727/tests/dromaeo/cssquery-mootools.html) 02:43:01 INFO - 2015-12-20 02:43:01,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 231014400 02:43:01 INFO - 2015-12-20 02:43:01,702 DEBUG : BROWSER_OUTPUT: 02:46:03 INFO - 2015-12-20 02:46:03,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57727/tests/dromaeo/cssquery-prototype.html) 02:46:04 INFO - 2015-12-20 02:46:04,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 214552576 02:46:04 INFO - 2015-12-20 02:46:04,283 DEBUG : BROWSER_OUTPUT: 02:49:07 INFO - 2015-12-20 02:49:07,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57727/tests/dromaeo/cssquery-yui.html) 02:49:07 INFO - 2015-12-20 02:49:07,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 218497024 02:49:07 INFO - 2015-12-20 02:49:07,675 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/dromaeo/cssquery-yui.html (next: http://localhost:57727/tests/dromaeo/cssquery-dojo.html) 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 262455296 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:52:10 INFO - 2015-12-20 02:52:10,563 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2627.3431642089477;2731.0987374166525;2743.9039633612815;2755.448910217957;2760.2547312225706;4539.273716205408;4645.605123564493;4773.4271887373525;4801.303810947411;4832.009438065197;4774.5464180902845;4781.426228852534;4846.466888642255;4850.296706977495;4953.504649535044;4403.735775853443;4409.228385032622;4433.445819272582;4519.34469501922;4521.796519156645;4191.287481128215;4523.36672865799;4523.547645235483;4576.130535198318;4597.241455159895;4303.569643035703;4314.180305741915;4344.196323680129;4396.626286765629;4435.711678740871;4428.2471979763195;4450.977745111286;4452.688311818174;4454.866354009385;4480.319880044983;4220.620144187007;4434.756088415136;4437.622802061828;4474.217012022916;4486.932696009562;4593.035462552834;4617.861464156081;4659.44086709597;4777.187878060703;4777.880552986168;5148.639595228336;5187.896242075175;5194.37667479901;5194.792208311663;5198.532132108128;5219.530242278175;5224.059669259532;5227.79088836446;5230.503102205284;5249.947500524984;4531.501534831199;4632.5830675239395;4635.096156249499;4725.716457012591;4858.514148585114;5313.840584782462;5327.547158491494;5331.333583302087;5341.893162136736;5342.732863356817;5101.489851014869;5107;5115.488451154854;5117.513836185556;5168.457311982188;4818.204996175662;4925.310456536088;4925.630577706686;4992.825251116194;5076.670016448919;5039.546440820343;5040.49595040493;5052.368453943257;5090.77091530882;5120.846374608767;5008.373953255843;5014.323066385991;5015.27278544609;5015.473375295542;5062.265971434195;3966.504186976628;4109.753414795122;4112.09533902541;4222.239996800606;4256.574342565718;3686.5207523021836;3737.8131093445218;3744.2511497700025;3776.773393596393;3786.450964610116;4381.145676593033;4383.254846676073;4386.363977223285;4412.713173643767;4426.402435671143;4803.711777293373;4905.117078925757;4908.582770464551;5126.179811230185;5178.896422071537;4336.414584031116;4388.210122177975;4400.053988392447;4402.3396490526675;4437.933430998538;4566.132434837436;4569.268916973335;4573;4581.2440947243995;4612.907741845144;4625.491195968508;4737.407824021997;4882.316475693406;4882.80468781259;4890.290907818276;4965.131102057053;4977.4524802271;5042.974785126051;5047.596192304681;5056.241563765465;4844.781984810622;4897.338859254098;4913.877153071202;4917.262410638433;4961.875953101057;4738;4848.418189817245;5119.948800512097;5127.769250383816;5182.97408512955;4982.177940639754;5017.0216807722145;5099.87250318745;5100.464451232716;5122.564582010571;5027.12025395547;5059.747012649279;5063.5695965843315;5065.518775716301;5109.054824857413;4651.767411629337;4808.014357056865;5054.241863720325;5060.620453465931;5070.062038522885;4738.549837765407;4800.687955282895;4858.368412106545;4877.585405240594;4897.534734200388;5043.899122017612;5045.217991211368;5050.217216331474;5052.924206136838;5053.69677819332;4943.332650092191;4945.554900059012;4945.876353091202;4947.2579113133315;4979.153543897473 02:52:10 INFO - 2015-12-20 02:52:10,564 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.3813804814704;565.683217398257;570.8030729398357;572.2074926227174;575.8474004388835;26904.59643105355;34525.309493810106;35291.82354088226;35304.117397065085;35349.646503534954;39103;39545.40681889767;39570.208595828066;39585.60414395855;39654.206915861665;6879.724811007553;6988.79033628992;7858.921410785904;8036.4776289541;8037.075736290314;10053.296269261155;10300.02149795772;10319.019693129141;10320.535575899103;10330.535125919352;9973.052560006823;10081.94959025204;10104.635874156967;10109.797804043914;10112.747181320452;7171.462140339443;7367.11594608645;9901;10005.999400059973;10071.949640251752;9866.112049915542;10003.89996100037;10014.549345279407;10019.198464122852;10021.549030293581;36762.81618591917;37341;37365.25269494622;37410.62589374126;37436;2957.0833041757123;3026.5946333164297;3100.3799240151834;3531.823408829548;3534.8335049433626;27815.721842781517;28403.857980709963;28406;28503.857480712464;28979.130626081253;3409.4647539104285;3442.6557344265625;3448.1207292140343;3530.858765649371;3568.7858728476376;215991;216740;216805;216862.91568542214;217163;44328;46044.53955460402;52670.47329526656;52968;53329;46829.29756053662;46862.5313746865;47111;47125.293120603215;47151.76424117857;13303.135296205715;13427.12723672958;13523.188608683511;13532.729345413234;13538.458461661423;10223.079922806983;10389.480525973671;10390.116840068678;10400;10626.415547144827;17804.3768468103;17997.460076197734;18030.63938721218;18030.819691803175;18034.729479057823;7252.238514955854;7614.657340419583;7620.542767433972;7627.656755446018;7640.197779233101;914.8810654614857;928.2713070239964;953.6757502449201;964.7973925475588;1069.6363236499471;26134;27312.388749557285;27471.725282747317;27527;29430.264243394085;934.1779234273796;956.5647630328184;970.1559643110539;1035.425338936882;1065.616378103882;12224.388780560936;12622.684432889251;12623.684407889692;12637.494500219887;12670.746585068431;203758;206172;206950;207747;207779;38764.41853372202;39263;39419.2116157681;39469.80265098656;39482.407763883566;1227.7544491101814;1229.4221715793562;1247.1394737631006;1258.2702032820941;1261.4575732435142;23810;30860.537091943188;31361.8431907839;32364;32432;42411.787941060094;42990;43036.139277214905;43103.56896431121;43112.568874310855;144049;146180;191682;199876;200707;39493.40759888662;39535.60464395319;39666.60333396745;39701.80149099236;39793;41857.79071104625;42015.78992105142;42208;42285.67428791446;42379.576204237565;36419.817900910326;36518.634813652585;36750.63249367579;37530.812345938095;37615.24769504649;35910.28179436449;36525.81737091298;37108.814455927546;37144;37235.81382093072;36314.8184259077;36487.635123648426;36500;36819;36962.8151859239;31682.366352673278;32217.35565288634;33247.66752332446;33361;33385.499217512246;25322.240332790047;25653.615195771705;27157.185284441497;27735.564586183173;27915.581266281428 02:52:10 INFO - 2015-12-20 02:52:10,564 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.5563178102984;316.8194129346273;316.93027533942524;322.6660406479293;328.7008821972006;12609.4325755341;12996.090273680846;14923.104613723184;15330.69338613227;15872.206389680514;12634.052446066537;14709.92645036776;15137.31882065307;15674.294656740445;15702.371905123782;4830.903381932368;4938.333325001133;4955.702657840541;5101.795928162869;5111.105556527611;3378.476336167898;3488.3197776433603;5041.798328066891;5088.872778180538;5089.389273287192;5139.383274007125;5171.922421163686;5206.505381988705;5211.088059589557;5211.218317252405;5161.096808058574;5161.200013997836;5308.761105750251;5630.183623374629;5665.688387138705;5009.774560144766;5041.8487445376695;5042.042012017741;5055.115354812893;5059.418166910816;12104.87895121055;12113.33376664283;12114.81827772584;12125.878741212564;16076.59808504785;1844.1516902224992;1859.172668162668;1863.487540926256;1916.4059141666128;1950.3856285270094;8583.828323433496;8772.298216142693;8934.955325223398;9093.954530227373;9142.634294628207;1434.8995570310083;1734.9392771253072;1753.1672455583623;1787.0885848217504;1807.2228941555127;49867.75066124683;50753.238701419505;52794.736026319624;54828.45171548273;57379.426205738244;8842.921913350357;9111.088891110836;9411.05889411067;9431.481268530297;9470.431774093577;12364.134510584352;12400.75198496043;12405.13164078524;12417.19288246261;12430.12989090773;6846.623435710984;6862;6909.861802764017;6942.7222911084;6949.93050069503;6512.088307636935;6572.309907459648;6577.177852768404;6628.4697224221945;6642.103316052271;4100.671946244293;4173.184664670878;4177.248095342868;4211.157768446323;4215.178040282116;1615.5799492131896;1672.339425926752;1677.337451706569;1736.956576085608;1766.5230387795223;372.5678213272591;859.862422012475;898.128815049401;906.6826610686339;1010.2322235101376;9452.149306562305;9557.23542116629;9732.951335243279;9808.411495310304;9862.309638325249;350.93156834417044;383.70646455461593;397.32454826793986;405.68559366490615;406.0518688861541;5390.21841832932;5520.641158324696;5572.86067848307;5630.662160270315;5635.802746903921;474112;477068;479102;493307;493599;67831.66084169547;70393.2960670397;71462;71680.64159679168;71772.64113679502;438.10626322302784;441.882901031227;445.06092145572813;445.08534960655516;445.48546428874704;9291.21024712907;9434.669786557437;9472.526373681427;9494.192993595345;9535.189508891544;29891;30514.389712206077;30546.541801872547;30685.07944761661;31103.68896311008;41628.37557436701;42340.576594233666;42709.35935960901;42827.357589636806;43113.13773724571;8427.873581896154;8486.448380855225;8568.828623427622;8576.742697719079;8733.257673097858;9884;9900.50497475109;9922.900770992197;9963.950180249343;12456.813147802972;12321.815172772594;12427.875721242672;12967.870321296667;13561;13577.52478663242;12854.550090747152;13206.735865282833;13271.402786874807;13351.599452016455;13505.86494135046;11051.613193538187;11511.76976460483;11910.166288359731;12654.493820247088;13227.735445291233;8408.495490270603;8548.316134709085;8589.570521473775;8875.423097498642;8879.511626860327;9274.582643780912;9303.069693030642;9305.255579553756;11592.768144636892;13463.932680336535 02:52:10 INFO - 2015-12-20 02:52:10,564 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1240.968975775605;1646.769452276681;1691.7208660571007;1727.1795896948943;1736.730806724958;5751.309842818857;7038.964805175973;7286.854262914739;7308.6345682715855;7309.232530584279;7273.0908636420445;7428.888566671504;7435.144958329794;7435.256474352562;7446.925530744691;1720.6300645361246;1765.3115285038846;1765.964680706385;2043.448268967378;2089.3418573149484;1766.5495298698813;2088.112552165331;2123.182574708733;2133.9039743211515;2137.444264491228;2028.9695654565194;2061.2991582861823;2072.9274475393363;2074.097767471147;2074.4191626344646;2077.158750705959;2102.621528124937;2104.1478201328487;2106.09437941685;2108.50450144216;2071.606394785001;2075.2321640992777;2104.947376315589;2107.3256557901477;2107.725995620575;7299.19708832028;7340.155882073523;7342.412606991428;7355.852882942365;7359.153697324823;4249.320108782611;4328.891777705551;4330.805113769857;4348.434703488558;4362.956370436286;2735.261479400551;2749.8762555684843;2782.4156927045346;2785.6378670772874;2804.3549983503704;879.4327658660128;886.4636894678691;891.7993451473432;903.7966457547066;914.0402577293814;9765.658201962968;9809.21526277896;9817.312788104835;9826.16477599405;9835.45904975226;3778.6977041837135;3796.468494410785;3871.593482684334;3922.1763429679518;3935.58676338986;8501.95749021251;8512.148785121562;8520.147985201555;8524.914750852537;8543.35924805642;4245.214635292481;4275.893102672458;4291.6566674665955;4292.012837047497;4296;3846.1346197105986;3863.613638636114;3877.6703980161437;3890.319194141014;3894.084890050836;2946.9410611787644;3446.8965931022108;3473.6005359383994;3523.224890524081;3526.5062891195253;979.6767066867917;1110.7611863449235;1121.5738019552682;1125.662301309604;1133.1557989298026;990.4206039466849;990.5790039233297;1023.7338292044122;1056.271172890703;1210.2194084815244;6801.795946121525;6842.897356539655;6847.589144651337;6865.759698410531;6872.553284036621;1043;1048.6591857646142;1049.5382031905938;1064.4518073192312;1068.053542161705;5272.604554658416;5347;5349.786008559692;5352.0366334060245;5354.384245811703;8681.350543396735;8760.255378292917;8958.014618391971;8962.372633915693;8975.506347150838;8831.337649676172;8849.380543361904;8862.980757213003;8866.157715017063;8869.113088691209;6783.898241526381;6904.27505111956;6958.686859091353;6958.860822783516;7007.054047703495;6565.803025909039;6586.769463068769;6588.374104460068;6603.471722262304;6603.900941485786;7508.699652013858;7716.922830771845;7828.45200835936;7849.254320839511;7931.524108553274;7625.351845093007;7913;7929.365650748042;7933.1670174630835;7979.601019949096;6283.685815709287;6407.167068281094;6462.870742585028;6566.376194261537;6577.6053436793945;5757.596968212185;5971.820845374646;7174.856502870018;7225.710971561079;7240.1311842579225;6252.09344645033;6378.489720822416;6506.154199953976;6509.218893732783;6590.242122155822;6249.875002500015;6273.278572964167;6410.5192110592825;6463.903041454476;6624.6025238485845;6338.366163383625;6495.188101487314;6548.8362790930605;6590.143281373391;6645.435138013323;5998.370171131968;6026.186464827192;6034.336223015377;6036.969815151072;6039.214902062704;5945.672987985529;6006.939930600638;6069.2110025696375;6099.054646529795;6101.084837274267 02:52:10 INFO - 2015-12-20 02:52:10,564 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.30197338228544;303.1647810282671;307.4558032282858;308.0266358307748;309.7800561601263;5420.593455490839;5433.809816656418;5464.754086066127;5469.863253418656;5476.3428388593375;5358.544523715479;5361.624686271953;5366.356037275533;5367.624266301361;5370.570354371651;4194.727342722728;4194.832206711728;4198.727082739612;4199.3910882921955;4200.516940551845;4000.2399544086675;4116.732412393185;4186.330187170053;4200.474940632421;4205.243056249874;3600.1539638185004;4007.7194596378267;4081.0409553754844;4087.7138600297844;4089.734167279132;4033.5764744701823;4077;4128;4128.60778226068;4131.008557946101;3457.861685532576;3656.9085772855624;3696.316181506403;3697.352963231424;3697.5932647408763;4980.800767969277;5110.080185566597;5126.92309615356;5159.509846564571;5240.030594340059;4745.1695953208055;4746.715197088151;4751.002289519205;4752.358431611723;4766.4995175506765;5664.830055098354;5677.716114194273;5682.034054210752;5685.431456854323;5686.346070201938;3904.4728961590104;3908.706846986459;3909.550401703812;3910.393888947218;3913.6869050475893;5794.304683438015;5869.471747542699;5960.910586341209;5962.224910761616;5966.642001479881;4010.5588385277597;4010.799460026987;4011.8194681239415;4012.9197416051516;4015.8393664253103;4070.9592904070582;4073.6944729145434;4077.327241005201;4077.571854955246;4078.2659121358442;4632.814687412533;4689.015306785614;4697.459792123881;4697.812087516461;4703.106409782131;5197.272381866542;5413.323334583177;5559;5662;5694;1419.5528408551274;1435.9497417590335;1438.129931391514;1438.7122575484946;1439.2515891736448;931.4411353188168;934.5654270763991;943.3820847345;976.9658061967939;977.0815433492636;4982;4988.052270068675;4991.226359914219;4996.850094497171;4997.700137991732;5894.351621321651;5898.174255604219;5902.026165682701;5904.409559044061;5908.497777688945;4981.6761910476425;4986.276989836453;4989.90020199594;4994.90010199794;4995.925061124086;3096.6903309669306;3099.860506277223;3174.5238214268043;3178.8092714436743;3181.44324743169;5603.187537806995;5617.21359009739;5623.325200975909;5627.240322556402;5628.577856660685;5798.072308430631;5918.556108291896;5943.375945525658;6120.816375508742;6131.478824299985;5557.916631250535;5587.385387607279;5596.496315331639;5602.327720673546;5612.550995920316;5936.525077993837;5940.227770389822;5944.048952167633;5946.910796337972;5948.524118070457;5656.066748986371;5724.484796368347;5743.4256574342235;5797.4057134288405;5803.854903627274;5588.385277619377;5590.440955904377;5593.580481463988;5599;5603.131514615241;3945.5659877412886;4001;4002;4005.7796821175116;4012.217617564547;5932.436418540232;5939.07944268639;5942.821715348547;5953.58324917269;5956.315023772148;5630.690312032878;5711.114777209539;5731.111677689964;5737.885242295048;5741.971290143522;5732.455416735404;5733.71331433435;5735.569832262514;5740.39725828782;5741;5603.859903502445;5610.270664813548;5610.85972850682;5610.915836262541;5611.57913156523;5619.662820230799;5770.076787713946;5784.421557844182;5785.913211301918;5798.449147330997;5649.12438572022;5650.943490565206;5657.236273103243;5659.236003139524;5661.207430959751 02:52:10 INFO - 2015-12-20 02:52:10,565 DEBUG : BROWSER_OUTPUT: |5;yui.html;704.0284407517624;747.7382915979405;781.156351140768;790.2808444315674;794.3327604811958;10448.529816158281;10612.78774424512;10671.253012289133;10702.78594428113;10724.517396717147;11791.823122653168;11894.226875253124;11926.284422934608;11997.700057498567;12019.939900300486;613.3314686991179;625.0031200235617;626.1859582542698;774.4462709162948;793.8690116130831;790.0479921694345;790.3242727468019;795.2167115391335;795.6578671171394;795.8527672380599;822.3544517553721;828.8508068547659;830.3979614779297;830.4228561150003;830.4353039932844;646.6378827856392;654.8592052708667;805.4040010392326;818.8976377952756;823.3413269384469;608.6104892868568;609.250621735268;609.3449541742644;609.7103875659071;610.1914962674474;11058.557657693682;11098.500567474483;11103.278286911325;11110.277831940897;11133.777324453466;10748.301360411548;11156.386398748065;11181.832272515838;11363.14776391774;11890.346030968294;9424.858627120599;9453.716388508286;9548.474833884133;9598.280128990284;9688.176504997013;3220.388126256004;3226.709596136359;3242;3282.2286762610765;3315.419801534722;36991;37123.443148352795;37188.07029824276;37227.62772372269;37254.81372593147;8958.641654333884;9230.400023998418;9235.584398702074;9361.531923403803;9431;15437.691246175014;15442.922785386001;15450.227488625524;15450.304736286895;15467.5359739208;6301.558890877594;6431;6497.935020649733;6525;6590.176227971504;3514.61339252682;3584.301061293023;3594.0116467971516;3640.453931910182;3642.7267954903486;2637.5648018077186;2674.6790385153904;2675.1038402135114;2679.7454241846995;2682.745139211772;468.7539042002908;469.6313393985773;471.0602348315065;471.24130150457734;471.2436539354287;559.7033572206736;564.7599770097692;578.673049726903;599.5802937943457;602.4006113916681;7246.710131594783;7401.851962960711;7438.516496427715;7480.476366654282;7500.174980752113;385.4545817667968;492.3894370979959;550.9669369931379;589.4724221821446;604.9425304596057;3530.293941211768;3615.6745892869244;3680.595134535199;3697.4268988306853;3702.20402613434;47124.52875471202;48016.27975580369;48390.75804620954;48524.757376212896;48751.756241218565;43819.342709859375;44285.33571996423;44446.11107777827;44907.32639010417;44993.10013799771;40194.79902600527;40234.59765402367;40425;40493;40784.3882341771;7192.568445893263;7279.235680253497;7304.780856574312;7387.4090072795125;7410.2219266978345;29498.262543436587;29928.102156935325;30044.24889377783;30056.69943300539;30493.932712354963;35871.103222419646;35902.820485897406;35991.64008359883;36134.4579831308;39034.80482597569;9837.458939758382;10008.299419040597;10149.086582207341;10324.690259292232;10370.844437333597;11113.333200008025;11285.153613478858;11309.208355415041;11389.487473063566;11533.653990380302;10136.543855526372;10322.690319290434;10331.070203681706;10436.634717785144;10922;10245.231607629308;10611.151107911193;10624.468776561296;10708.89291107079;10886.891131088905;10064.547095380873;10379.377237365783;10581.259311848096;10585.472652623434;10921.945390272998;8832.251580547283;8946.284297256074;9077.546122693706;9252.306077044383;9396.342256042011;8757.868631970652;9229.630814767603;9233.58448869789;9316.94084616788;9426.57580408897 02:52:10 INFO - 2015-12-20 02:52:10,565 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:52:10 INFO - 2015-12-20 02:52:10,565 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608730556__endTimestamp 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,566 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4714.49 Median:4848.42 stddev:498.81 (10.3%) stddev-sans-first:472.71 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: Values: 2627.3 2731.1 2743.9 2755.4 2760.3 4539.3 4645.6 4773.4 4801.3 4832.0 4774.5 4781.4 4846.5 4850.3 4953.5 4403.7 4409.2 4433.4 4519.3 4521.8 4191.3 4523.4 4523.5 4576.1 4597.2 4303.6 4314.2 4344.2 4396.6 4435.7 4428.2 4451.0 4452.7 4454.9 4480.3 4220.6 4434.8 4437.6 4474.2 4486.9 4593.0 4617.9 4659.4 4777.2 4777.9 5148.6 5187.9 5194.4 5194.8 5198.5 5219.5 5224.1 5227.8 5230.5 5249.9 4531.5 4632.6 4635.1 4725.7 4858.5 5313.8 5327.5 5331.3 5341.9 5342.7 5101.5 5107.0 5115.5 5117.5 5168.5 4818.2 4925.3 4925.6 4992.8 5076.7 5039.5 5040.5 5052.4 5090.8 5120.8 5008.4 5014.3 5015.3 5015.5 5062.3 3966.5 4109.8 4112.1 4222.2 4256.6 3686.5 3737.8 3744.3 3776.8 3786.5 4381.1 4383.3 4386.4 4412.7 4426.4 4803.7 4905.1 4908.6 5126.2 5178.9 4336.4 4388.2 4400.1 4402.3 4437.9 4566.1 4569.3 4573.0 4581.2 4612.9 4625.5 4737.4 4882.3 4882.8 4890.3 4965.1 4977.5 5043.0 5047.6 5056.2 4844.8 4897.3 4913.9 4917.3 4961.9 4738.0 4848.4 5119.9 5127.8 5183.0 4982.2 5017.0 5099.9 5100.5 5122.6 5027.1 5059.7 5063.6 5065.5 5109.1 4651.8 4808.0 5054.2 5060.6 5070.1 4738.5 4800.7 4858.4 4877.6 4897.5 5043.9 5045.2 5050.2 5052.9 5053.7 4943.3 4945.6 4945.9 4947.3 4979.2 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37391.70 Median:34908.57 stddev:51852.52 (148.5%) stddev-sans-first:51924.23 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: Values: 562.4 565.7 570.8 572.2 575.8 26904.6 34525.3 35291.8 35304.1 35349.6 39103.0 39545.4 39570.2 39585.6 39654.2 6879.7 6988.8 7858.9 8036.5 8037.1 10053.3 10300.0 10319.0 10320.5 10330.5 9973.1 10081.9 10104.6 10109.8 10112.7 7171.5 7367.1 9901.0 10006.0 10071.9 9866.1 10003.9 10014.5 10019.2 10021.5 36762.8 37341.0 37365.3 37410.6 37436.0 2957.1 3026.6 3100.4 3531.8 3534.8 27815.7 28403.9 28406.0 28503.9 28979.1 3409.5 3442.7 3448.1 3530.9 3568.8 215991.0 216740.0 216805.0 216862.9 217163.0 44328.0 46044.5 52670.5 52968.0 53329.0 46829.3 46862.5 47111.0 47125.3 47151.8 13303.1 13427.1 13523.2 13532.7 13538.5 10223.1 10389.5 10390.1 10400.0 10626.4 17804.4 17997.5 18030.6 18030.8 18034.7 7252.2 7614.7 7620.5 7627.7 7640.2 914.9 928.3 953.7 964.8 1069.6 26134.0 27312.4 27471.7 27527.0 29430.3 934.2 956.6 970.2 1035.4 1065.6 12224.4 12622.7 12623.7 12637.5 12670.7 203758.0 206172.0 206950.0 207747.0 207779.0 38764.4 39263.0 39419.2 39469.8 39482.4 1227.8 1229.4 1247.1 1258.3 1261.5 23810.0 30860.5 31361.8 32364.0 32432.0 42411.8 42990.0 43036.1 43103.6 43112.6 144049.0 146180.0 191682.0 199876.0 200707.0 39493.4 39535.6 39666.6 39701.8 39793.0 41857.8 42015.8 42208.0 42285.7 42379.6 36419.8 36518.6 36750.6 37530.8 37615.2 35910.3 36525.8 37108.8 37144.0 37235.8 36314.8 36487.6 36500.0 36819.0 36962.8 31682.4 32217.4 33247.7 33361.0 33385.5 25322.2 25653.6 27157.2 27735.6 27915.6 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25110.27 Median:249068.95 stddev:79080.22 (31.8%) stddev-sans-first:79280.14 02:52:10 INFO - 2015-12-20 02:52:10,568 DEBUG : BROWSER_OUTPUT: Values: 313.6 316.8 316.9 322.7 328.7 12609.4 12996.1 14923.1 15330.7 15872.2 12634.1 14709.9 15137.3 15674.3 15702.4 4830.9 4938.3 4955.7 5101.8 5111.1 3378.5 3488.3 5041.8 5088.9 5089.4 5139.4 5171.9 5206.5 5211.1 5211.2 5161.1 5161.2 5308.8 5630.2 5665.7 5009.8 5041.8 5042.0 5055.1 5059.4 12104.9 12113.3 12114.8 12125.9 16076.6 1844.2 1859.2 1863.5 1916.4 1950.4 8583.8 8772.3 8935.0 9094.0 9142.6 1434.9 1734.9 1753.2 1787.1 1807.2 49867.8 50753.2 52794.7 54828.5 57379.4 8842.9 9111.1 9411.1 9431.5 9470.4 12364.1 12400.8 12405.1 12417.2 12430.1 6846.6 6862.0 6909.9 6942.7 6949.9 6512.1 6572.3 6577.2 6628.5 6642.1 4100.7 4173.2 4177.2 4211.2 4215.2 1615.6 1672.3 1677.3 1737.0 1766.5 372.6 859.9 898.1 906.7 1010.2 9452.1 9557.2 9733.0 9808.4 9862.3 350.9 383.7 397.3 405.7 406.1 5390.2 5520.6 5572.9 5630.7 5635.8 474112.0 477068.0 479102.0 493307.0 493599.0 67831.7 70393.3 71462.0 71680.6 71772.6 438.1 441.9 445.1 445.1 445.5 9291.2 9434.7 9472.5 9494.2 9535.2 29891.0 30514.4 30546.5 30685.1 31103.7 41628.4 42340.6 42709.4 42827.4 43113.1 8427.9 8486.4 8568.8 8576.7 8733.3 9884.0 9900.5 9922.9 9964.0 12456.8 12321.8 12427.9 12967.9 13561.0 13577.5 12854.6 13206.7 13271.4 13351.6 13505.9 11051.6 11511.8 11910.2 12654.5 13227.7 8408.5 8548.3 8589.6 8875.4 8879.5 9274.6 9303.1 9305.3 11592.8 13463.9 02:52:10 INFO - 2015-12-20 02:52:10,569 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,569 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5056.59 Median:6250.98 stddev:2644.06 (42.3%) stddev-sans-first:2635.92 02:52:10 INFO - 2015-12-20 02:52:10,570 DEBUG : BROWSER_OUTPUT: Values: 1241.0 1646.8 1691.7 1727.2 1736.7 5751.3 7039.0 7286.9 7308.6 7309.2 7273.1 7428.9 7435.1 7435.3 7446.9 1720.6 1765.3 1766.0 2043.4 2089.3 1766.5 2088.1 2123.2 2133.9 2137.4 2029.0 2061.3 2072.9 2074.1 2074.4 2077.2 2102.6 2104.1 2106.1 2108.5 2071.6 2075.2 2104.9 2107.3 2107.7 7299.2 7340.2 7342.4 7355.9 7359.2 4249.3 4328.9 4330.8 4348.4 4363.0 2735.3 2749.9 2782.4 2785.6 2804.4 879.4 886.5 891.8 903.8 914.0 9765.7 9809.2 9817.3 9826.2 9835.5 3778.7 3796.5 3871.6 3922.2 3935.6 8502.0 8512.1 8520.1 8524.9 8543.4 4245.2 4275.9 4291.7 4292.0 4296.0 3846.1 3863.6 3877.7 3890.3 3894.1 2946.9 3446.9 3473.6 3523.2 3526.5 979.7 1110.8 1121.6 1125.7 1133.2 990.4 990.6 1023.7 1056.3 1210.2 6801.8 6842.9 6847.6 6865.8 6872.6 1043.0 1048.7 1049.5 1064.5 1068.1 5272.6 5347.0 5349.8 5352.0 5354.4 8681.4 8760.3 8958.0 8962.4 8975.5 8831.3 8849.4 8863.0 8866.2 8869.1 6783.9 6904.3 6958.7 6958.9 7007.1 6565.8 6586.8 6588.4 6603.5 6603.9 7508.7 7716.9 7828.5 7849.3 7931.5 7625.4 7913.0 7929.4 7933.2 7979.6 6283.7 6407.2 6462.9 6566.4 6577.6 5757.6 5971.8 7174.9 7225.7 7240.1 6252.1 6378.5 6506.2 6509.2 6590.2 6249.9 6273.3 6410.5 6463.9 6624.6 6338.4 6495.2 6548.8 6590.1 6645.4 5998.4 6026.2 6034.3 6037.0 6039.2 5945.7 6006.9 6069.2 6099.1 6101.1 02:52:10 INFO - 2015-12-20 02:52:10,570 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,570 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4697.89 Median:5391.95 stddev:1400.46 (26.0%) stddev-sans-first:1364.90 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: Values: 298.3 303.2 307.5 308.0 309.8 5420.6 5433.8 5464.8 5469.9 5476.3 5358.5 5361.6 5366.4 5367.6 5370.6 4194.7 4194.8 4198.7 4199.4 4200.5 4000.2 4116.7 4186.3 4200.5 4205.2 3600.2 4007.7 4081.0 4087.7 4089.7 4033.6 4077.0 4128.0 4128.6 4131.0 3457.9 3656.9 3696.3 3697.4 3697.6 4980.8 5110.1 5126.9 5159.5 5240.0 4745.2 4746.7 4751.0 4752.4 4766.5 5664.8 5677.7 5682.0 5685.4 5686.3 3904.5 3908.7 3909.6 3910.4 3913.7 5794.3 5869.5 5960.9 5962.2 5966.6 4010.6 4010.8 4011.8 4012.9 4015.8 4071.0 4073.7 4077.3 4077.6 4078.3 4632.8 4689.0 4697.5 4697.8 4703.1 5197.3 5413.3 5559.0 5662.0 5694.0 1419.6 1435.9 1438.1 1438.7 1439.3 931.4 934.6 943.4 977.0 977.1 4982.0 4988.1 4991.2 4996.9 4997.7 5894.4 5898.2 5902.0 5904.4 5908.5 4981.7 4986.3 4989.9 4994.9 4995.9 3096.7 3099.9 3174.5 3178.8 3181.4 5603.2 5617.2 5623.3 5627.2 5628.6 5798.1 5918.6 5943.4 6120.8 6131.5 5557.9 5587.4 5596.5 5602.3 5612.6 5936.5 5940.2 5944.0 5946.9 5948.5 5656.1 5724.5 5743.4 5797.4 5803.9 5588.4 5590.4 5593.6 5599.0 5603.1 3945.6 4001.0 4002.0 4005.8 4012.2 5932.4 5939.1 5942.8 5953.6 5956.3 5630.7 5711.1 5731.1 5737.9 5742.0 5732.5 5733.7 5735.6 5740.4 5741.0 5603.9 5610.3 5610.9 5610.9 5611.6 5619.7 5770.1 5784.4 5785.9 5798.4 5649.1 5650.9 5657.2 5659.2 5661.2 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11879.76 Median:44052.34 stddev:13291.07 (30.2%) stddev-sans-first:13301.86 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: Values: 704.0 747.7 781.2 790.3 794.3 10448.5 10612.8 10671.3 10702.8 10724.5 11791.8 11894.2 11926.3 11997.7 12019.9 613.3 625.0 626.2 774.4 793.9 790.0 790.3 795.2 795.7 795.9 822.4 828.9 830.4 830.4 830.4 646.6 654.9 805.4 818.9 823.3 608.6 609.3 609.3 609.7 610.2 11058.6 11098.5 11103.3 11110.3 11133.8 10748.3 11156.4 11181.8 11363.1 11890.3 9424.9 9453.7 9548.5 9598.3 9688.2 3220.4 3226.7 3242.0 3282.2 3315.4 36991.0 37123.4 37188.1 37227.6 37254.8 8958.6 9230.4 9235.6 9361.5 9431.0 15437.7 15442.9 15450.2 15450.3 15467.5 6301.6 6431.0 6497.9 6525.0 6590.2 3514.6 3584.3 3594.0 3640.5 3642.7 2637.6 2674.7 2675.1 2679.7 2682.7 468.8 469.6 471.1 471.2 471.2 559.7 564.8 578.7 599.6 602.4 7246.7 7401.9 7438.5 7480.5 7500.2 385.5 492.4 551.0 589.5 604.9 3530.3 3615.7 3680.6 3697.4 3702.2 47124.5 48016.3 48390.8 48524.8 48751.8 43819.3 44285.3 44446.1 44907.3 44993.1 40194.8 40234.6 40425.0 40493.0 40784.4 7192.6 7279.2 7304.8 7387.4 7410.2 29498.3 29928.1 30044.2 30056.7 30493.9 35871.1 35902.8 35991.6 36134.5 39034.8 9837.5 10008.3 10149.1 10324.7 10370.8 11113.3 11285.2 11309.2 11389.5 11533.7 10136.5 10322.7 10331.1 10436.6 10922.0 10245.2 10611.2 10624.5 10708.9 10886.9 10064.5 10379.4 10581.3 10585.5 10921.9 8832.3 8946.3 9077.5 9252.3 9396.3 8757.9 9229.6 9233.6 9316.9 9426.6 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:52:10 INFO - 2015-12-20 02:52:10,571 DEBUG : BROWSER_OUTPUT: 02:52:11 INFO - 2015-12-20 02:52:11,316 INFO : Browser exited with error code: 0 02:52:11 INFO - 2015-12-20 02:52:11,335 INFO : Completed test dromaeo_css (00:18:37) 02:52:11 INFO - 2015-12-20 02:52:11,335 INFO : Starting test kraken 02:52:11 INFO - 2015-12-20 02:52:11,335 DEBUG : operating with platform_type : linux_ 02:52:11 INFO - 2015-12-20 02:52:11,335 INFO : Initialising browser for kraken test... 02:52:11 INFO - 2015-12-20 02:52:11,341 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKS1Ca/profile http://localhost:57727/getInfo.html 02:52:15 INFO - 2015-12-20 02:52:15,692 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:52:15 INFO - 2015-12-20 02:52:15,713 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:52:15 INFO - 2015-12-20 02:52:15,713 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:52:15 INFO - 2015-12-20 02:52:15,713 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:52:15 INFO - 2015-12-20 02:52:15,713 DEBUG : BROWSER_OUTPUT: __metrics 02:52:15 INFO - 2015-12-20 02:52:15,774 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:52:15 INFO - 2015-12-20 02:52:15,854 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:16 INFO - 2015-12-20 02:52:16,610 INFO : Browser initialized. 02:52:16 INFO - 2015-12-20 02:52:16,611 INFO : Running cycle 1/1 for kraken test... 02:52:16 INFO - 2015-12-20 02:52:16,611 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgKS1Ca/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:52:28 INFO - 2015-12-20 02:52:28,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 149610496 02:52:28 INFO - 2015-12-20 02:52:28,597 DEBUG : BROWSER_OUTPUT: 02:52:31 INFO - 2015-12-20 02:52:31,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57727/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:31 INFO - 2015-12-20 02:52:31,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 183689216 02:52:31 INFO - 2015-12-20 02:52:31,742 DEBUG : BROWSER_OUTPUT: 02:52:34 INFO - 2015-12-20 02:52:34,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57727/tests/kraken/driver.html?testName=audio-dft) 02:52:35 INFO - 2015-12-20 02:52:35,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 173928448 02:52:35 INFO - 2015-12-20 02:52:35,086 DEBUG : BROWSER_OUTPUT: 02:52:38 INFO - 2015-12-20 02:52:38,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57727/tests/kraken/driver.html?testName=audio-fft) 02:52:38 INFO - 2015-12-20 02:52:38,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 162562048 02:52:38 INFO - 2015-12-20 02:52:38,647 DEBUG : BROWSER_OUTPUT: 02:52:40 INFO - 2015-12-20 02:52:40,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57727/tests/kraken/driver.html?testName=audio-oscillator) 02:52:41 INFO - 2015-12-20 02:52:41,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 162492416 02:52:41 INFO - 2015-12-20 02:52:41,254 DEBUG : BROWSER_OUTPUT: 02:52:43 INFO - 2015-12-20 02:52:43,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:44 INFO - 2015-12-20 02:52:44,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 164999168 02:52:44 INFO - 2015-12-20 02:52:44,048 DEBUG : BROWSER_OUTPUT: 02:52:47 INFO - 2015-12-20 02:52:47,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57727/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:47 INFO - 2015-12-20 02:52:47,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 165515264 02:52:47 INFO - 2015-12-20 02:52:47,575 DEBUG : BROWSER_OUTPUT: 02:52:50 INFO - 2015-12-20 02:52:50,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57727/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:51 INFO - 2015-12-20 02:52:51,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 164794368 02:52:51 INFO - 2015-12-20 02:52:51,558 DEBUG : BROWSER_OUTPUT: 02:52:54 INFO - 2015-12-20 02:52:54,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57727/tests/kraken/driver.html?testName=json-parse-financial) 02:52:54 INFO - 2015-12-20 02:52:54,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 166842368 02:52:54 INFO - 2015-12-20 02:52:54,945 DEBUG : BROWSER_OUTPUT: 02:52:56 INFO - 2015-12-20 02:52:56,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:57 INFO - 2015-12-20 02:52:57,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 174657536 02:52:57 INFO - 2015-12-20 02:52:57,306 DEBUG : BROWSER_OUTPUT: 02:52:59 INFO - 2015-12-20 02:52:59,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:59 INFO - 2015-12-20 02:52:59,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 172445696 02:52:59 INFO - 2015-12-20 02:52:59,760 DEBUG : BROWSER_OUTPUT: 02:53:01 INFO - 2015-12-20 02:53:01,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:02 INFO - 2015-12-20 02:53:02,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 186138624 02:53:02 INFO - 2015-12-20 02:53:02,474 DEBUG : BROWSER_OUTPUT: 02:53:04 INFO - 2015-12-20 02:53:04,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:05 INFO - 2015-12-20 02:53:05,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 189636608 02:53:05 INFO - 2015-12-20 02:53:05,575 DEBUG : BROWSER_OUTPUT: 02:53:08 INFO - 2015-12-20 02:53:08,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:08 INFO - 2015-12-20 02:53:08,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 187207680 02:53:08 INFO - 2015-12-20 02:53:08,732 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57727/tests/kraken/driver.html?testName=ai-astar) 02:53:10 INFO - 2015-12-20 02:53:10,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 245460992 02:53:10 INFO - 2015-12-20 02:53:10,745 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;110;113;111;101;111;112;103 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;138;157;163;139;162;158;137;166;132 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;164;162;164;162;162;161 02:53:10 INFO - 2015-12-20 02:53:10,749 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;80;95;72;73;72;99;100;73 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;94;94;134;94;95;128 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;109;110;109;110 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;146;147;147;146;147;146;148 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;73;71;72;72;72;83;71;71 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;68;68;68;67;67;67 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;93;83;83;89;86;84;86;84;84 02:53:10 INFO - 2015-12-20 02:53:10,750 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;119;124;119;125;119;118;126;120;124 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;146;153;145;144;134;146;144;137;139 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;72;70;70;70;70;70;70;70 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:53:10 INFO - 2015-12-20 02:53:10,751 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608790747__endTimestamp 02:53:10 INFO - 2015-12-20 02:53:10,752 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.22 (3.8%) stddev-sans-first:4.46 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 110.0 113.0 111.0 101.0 111.0 112.0 103.0 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.00 stddev:13.02 (8.2%) stddev-sans-first:13.41 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: Values: 160.0 138.0 157.0 163.0 139.0 162.0 158.0 137.0 166.0 132.0 02:53:10 INFO - 2015-12-20 02:53:10,755 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 164.0 162.0 164.0 162.0 162.0 161.0 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:73.00 stddev:12.10 (16.6%) stddev-sans-first:12.39 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 80.0 95.0 72.0 73.0 72.0 99.0 100.0 73.0 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:94.00 stddev:17.73 (18.9%) stddev-sans-first:18.40 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 94.0 94.0 134.0 94.0 95.0 128.0 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 109.0 110.0 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 148.0 02:53:10 INFO - 2015-12-20 02:53:10,756 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.00 stddev:3.63 (5.0%) stddev-sans-first:3.86 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 73.0 71.0 72.0 72.0 72.0 83.0 71.0 71.0 02:53:10 INFO - 2015-12-20 02:53:10,757 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 67.0 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.34 (3.9%) stddev-sans-first:3.31 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: Values: 82.0 93.0 83.0 83.0 89.0 86.0 84.0 86.0 84.0 84.0 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.00 stddev:3.27 (2.6%) stddev-sans-first:3.13 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: Values: 126.0 119.0 124.0 119.0 125.0 119.0 118.0 126.0 120.0 124.0 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.00 stddev:5.38 (3.7%) stddev-sans-first:5.67 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 153.0 145.0 144.0 134.0 146.0 144.0 137.0 139.0 02:53:10 INFO - 2015-12-20 02:53:10,758 DEBUG : BROWSER_OUTPUT: 02:53:10 INFO - 2015-12-20 02:53:10,759 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 02:53:10 INFO - 2015-12-20 02:53:10,759 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 72.0 70.0 70.0 70.0 70.0 70.0 70.0 70.0 02:53:10 INFO - 2015-12-20 02:53:10,759 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:10 INFO - 2015-12-20 02:53:10,759 DEBUG : BROWSER_OUTPUT: 02:53:11 INFO - 2015-12-20 02:53:11,596 INFO : Browser exited with error code: 0 02:53:11 INFO - 2015-12-20 02:53:11,652 INFO : Completed test kraken (00:01:00) 02:53:11 INFO - 2015-12-20 02:53:11,652 INFO : Starting test v8_7 02:53:11 INFO - 2015-12-20 02:53:11,652 DEBUG : operating with platform_type : linux_ 02:53:11 INFO - 2015-12-20 02:53:11,653 INFO : Initialising browser for v8_7 test... 02:53:11 INFO - 2015-12-20 02:53:11,659 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1BpSIz/profile http://localhost:57727/getInfo.html 02:53:16 INFO - 2015-12-20 02:53:16,017 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 02:53:16 INFO - 2015-12-20 02:53:16,038 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:53:16 INFO - 2015-12-20 02:53:16,038 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:53:16 INFO - 2015-12-20 02:53:16,038 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:53:16 INFO - 2015-12-20 02:53:16,038 DEBUG : BROWSER_OUTPUT: __metrics 02:53:16 INFO - 2015-12-20 02:53:16,156 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:53:16 INFO - 2015-12-20 02:53:16,219 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:16 INFO - 2015-12-20 02:53:16,559 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:53:17 INFO - 2015-12-20 02:53:17,228 INFO : Browser initialized. 02:53:17 INFO - 2015-12-20 02:53:17,229 INFO : Running cycle 1/1 for v8_7 test... 02:53:17 INFO - 2015-12-20 02:53:17,229 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1BpSIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:29 INFO - 2015-12-20 02:53:29,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 148463616 02:53:29 INFO - 2015-12-20 02:53:29,213 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57727/tests/v8_7/run.html (next: http://localhost:57727/tests/v8_7/run.html) 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 447901696 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: |0;Richards;168.18028927009755 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.87360594795538 02:53:50 INFO - 2015-12-20 02:53:50,826 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2070.3933747412007 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |7;RegExp;27135.135135135137 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |8;Splay;620.7324643078833 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 02:53:50 INFO - 2015-12-20 02:53:50,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: __startTimestamp1450608830824__endTimestamp 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,828 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.18 Median:168.18 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,829 DEBUG : BROWSER_OUTPUT: Values: 168.2 02:53:50 INFO - 2015-12-20 02:53:50,829 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,829 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.87 Median:185.87 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,829 DEBUG : BROWSER_OUTPUT: Values: 185.9 02:53:50 INFO - 2015-12-20 02:53:50,829 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: Values: 278.4 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: Values: 5186.5 02:53:50 INFO - 2015-12-20 02:53:50,831 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2070.39 Median:2070.39 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: Values: 2070.4 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: Values: 787.4 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: Values: 12216.9 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,832 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27135.14 Median:27135.14 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: Values: 27135.1 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.73 Median:620.73 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: Values: 620.7 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: Values: 4845.4 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:50 INFO - 2015-12-20 02:53:50,833 DEBUG : BROWSER_OUTPUT: 02:53:51 INFO - 2015-12-20 02:53:51,744 INFO : Browser exited with error code: 0 02:53:51 INFO - 2015-12-20 02:53:51,759 INFO : Completed test v8_7 (00:00:40) 02:53:51 INFO - 2015-12-20 02:53:51,904 INFO : Completed test suite (00:20:18) 02:53:51 INFO - 2015-12-20 02:53:51,905 DEBUG : Working with test: dromaeo_css 02:53:51 INFO - 2015-12-20 02:53:51,905 DEBUG : Generating results file: dromaeo_css 02:53:51 INFO - 2015-12-20 02:53:51,906 DEBUG : Working with test: kraken 02:53:51 INFO - 2015-12-20 02:53:51,906 DEBUG : Generating results file: kraken 02:53:51 INFO - 2015-12-20 02:53:51,906 INFO : javascript benchmark 02:53:51 INFO - 2015-12-20 02:53:51,906 DEBUG : Working with test: v8_7 02:53:51 INFO - 2015-12-20 02:53:51,907 DEBUG : Generating results file: v8_7 02:53:51 INFO - 2015-12-20 02:53:51,907 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:53:52 INFO - 2015-12-20 02:53:52,025 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 02:53:52 INFO - 2015-12-20 02:53:52,025 DEBUG : process_Request line: dromaeo_css 6210.02 graph.html#tests=[[72,132,35]] 02:53:52 INFO - 2015-12-20 02:53:52,025 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:53:52 INFO - 2015-12-20 02:53:52,146 DEBUG : process_Request line: kraken 1521.10 graph.html#tests=[[232,132,35]] 02:53:52 INFO - 2015-12-20 02:53:52,147 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:53:52 INFO - 2015-12-20 02:53:52,173 DEBUG : process_Request line: v8_7 19628.71 graph.html#tests=[[230,132,35]] 02:53:52 INFO - 2015-12-20 02:53:52,175 INFO : javascript benchmark 02:53:52 INFO - 2015-12-20 02:53:52,178 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2627.3431642089477, 2731.0987374166525, 2743.9039633612815, 2755.448910217957, 2760.2547312225706, 4539.273716205408, 4645.605123564493, 4773.4271887373525, 4801.303810947411, 4832.009438065197, 4774.5464180902845, 4781.426228852534, 4846.466888642255, 4850.296706977495, 4953.504649535044, 4403.735775853443, 4409.228385032622, 4433.445819272582, 4519.34469501922, 4521.796519156645, 4191.287481128215, 4523.36672865799, 4523.547645235483, 4576.130535198318, 4597.241455159895, 4303.569643035703, 4314.180305741915, 4344.196323680129, 4396.626286765629, 4435.711678740871, 4428.2471979763195, 4450.977745111286, 4452.688311818174, 4454.866354009385, 4480.319880044983, 4220.620144187007, 4434.756088415136, 4437.622802061828, 4474.217012022916, 4486.932696009562, 4593.035462552834, 4617.861464156081, 4659.44086709597, 4777.187878060703, 4777.880552986168, 5148.639595228336, 5187.896242075175, 5194.37667479901, 5194.792208311663, 5198.532132108128, 5219.530242278175, 5224.059669259532, 5227.79088836446, 5230.503102205284, 5249.947500524984, 4531.501534831199, 4632.5830675239395, 4635.096156249499, 4725.716457012591, 4858.514148585114, 5313.840584782462, 5327.547158491494, 5331.333583302087, 5341.893162136736, 5342.732863356817, 5101.489851014869, 5107.0, 5115.488451154854, 5117.513836185556, 5168.457311982188, 4818.204996175662, 4925.310456536088, 4925.630577706686, 4992.825251116194, 5076.670016448919, 5039.546440820343, 5040.49595040493, 5052.368453943257, 5090.77091530882, 5120.846374608767, 5008.373953255843, 5014.323066385991, 5015.27278544609, 5015.473375295542, 5062.265971434195, 3966.504186976628, 4109.753414795122, 4112.09533902541, 4222.239996800606, 4256.574342565718, 3686.5207523021836, 3737.8131093445218, 3744.2511497700025, 3776.773393596393, 3786.450964610116, 4381.145676593033, 4383.254846676073, 4386.363977223285, 4412.713173643767, 4426.402435671143, 4803.711777293373, 4905.117078925757, 4908.582770464551, 5126.179811230185, 5178.896422071537, 4336.414584031116, 4388.210122177975, 4400.053988392447, 4402.3396490526675, 4437.933430998538, 4566.132434837436, 4569.268916973335, 4573.0, 4581.2440947243995, 4612.907741845144, 4625.491195968508, 4737.407824021997, 4882.316475693406, 4882.80468781259, 4890.290907818276, 4965.131102057053, 4977.4524802271, 5042.974785126051, 5047.596192304681, 5056.241563765465, 4844.781984810622, 4897.338859254098, 4913.877153071202, 4917.262410638433, 4961.875953101057, 4738.0, 4848.418189817245, 5119.948800512097, 5127.769250383816, 5182.97408512955, 4982.177940639754, 5017.0216807722145, 5099.87250318745, 5100.464451232716, 5122.564582010571, 5027.12025395547, 5059.747012649279, 5063.5695965843315, 5065.518775716301, 5109.054824857413, 4651.767411629337, 4808.014357056865, 5054.241863720325, 5060.620453465931, 5070.062038522885, 4738.549837765407, 4800.687955282895, 4858.368412106545, 4877.585405240594, 4897.534734200388, 5043.899122017612, 5045.217991211368, 5050.217216331474, 5052.924206136838, 5053.69677819332, 4943.332650092191, 4945.554900059012, 4945.876353091202, 4947.2579113133315, 4979.153543897473], "unit": "score", "name": "dojo.html", "value": 4683.386961272145}, {"lowerIsBetter": false, "replicates": [562.3813804814704, 565.683217398257, 570.8030729398357, 572.2074926227174, 575.8474004388835, 26904.59643105355, 34525.309493810106, 35291.82354088226, 35304.117397065085, 35349.646503534954, 39103.0, 39545.40681889767, 39570.208595828066, 39585.60414395855, 39654.206915861665, 6879.724811007553, 6988.79033628992, 7858.921410785904, 8036.4776289541, 8037.075736290314, 10053.296269261155, 10300.02149795772, 10319.019693129141, 10320.535575899103, 10330.535125919352, 9973.052560006823, 10081.94959025204, 10104.635874156967, 10109.797804043914, 10112.747181320452, 7171.462140339443, 7367.11594608645, 9901.0, 10005.999400059973, 10071.949640251752, 9866.112049915542, 10003.89996100037, 10014.549345279407, 10019.198464122852, 10021.549030293581, 36762.81618591917, 37341.0, 37365.25269494622, 37410.62589374126, 37436.0, 2957.0833041757123, 3026.5946333164297, 3100.3799240151834, 3531.823408829548, 3534.8335049433626, 27815.721842781517, 28403.857980709963, 28406.0, 28503.857480712464, 28979.130626081253, 3409.4647539104285, 3442.6557344265625, 3448.1207292140343, 3530.858765649371, 3568.7858728476376, 215991.0, 216740.0, 216805.0, 216862.91568542214, 217163.0, 44328.0, 46044.53955460402, 52670.47329526656, 52968.0, 53329.0, 46829.29756053662, 46862.5313746865, 47111.0, 47125.293120603215, 47151.76424117857, 13303.135296205715, 13427.12723672958, 13523.188608683511, 13532.729345413234, 13538.458461661423, 10223.079922806983, 10389.480525973671, 10390.116840068678, 10400.0, 10626.415547144827, 17804.3768468103, 17997.460076197734, 18030.63938721218, 18030.819691803175, 18034.729479057823, 7252.238514955854, 7614.657340419583, 7620.542767433972, 7627.656755446018, 7640.197779233101, 914.8810654614857, 928.2713070239964, 953.6757502449201, 964.7973925475588, 1069.6363236499471, 26134.0, 27312.388749557285, 27471.725282747317, 27527.0, 29430.264243394085, 934.1779234273796, 956.5647630328184, 970.1559643110539, 1035.425338936882, 1065.616378103882, 12224.388780560936, 12622.684432889251, 12623.684407889692, 12637.494500219887, 12670.746585068431, 203758.0, 206172.0, 206950.0, 207747.0, 207779.0, 38764.41853372202, 39263.0, 39419.2116157681, 39469.80265098656, 39482.407763883566, 1227.7544491101814, 1229.4221715793562, 1247.1394737631006, 1258.2702032820941, 1261.4575732435142, 23810.0, 30860.537091943188, 31361.8431907839, 32364.0, 32432.0, 42411.787941060094, 42990.0, 43036.139277214905, 43103.56896431121, 43112.568874310855, 144049.0, 146180.0, 191682.0, 199876.0, 200707.0, 39493.40759888662, 39535.60464395319, 39666.60333396745, 39701.80149099236, 39793.0, 41857.79071104625, 42015.78992105142, 42208.0, 42285.67428791446, 42379.576204237565, 36419.817900910326, 36518.634813652585, 36750.63249367579, 37530.812345938095, 37615.24769504649, 35910.28179436449, 36525.81737091298, 37108.814455927546, 37144.0, 37235.81382093072, 36314.8184259077, 36487.635123648426, 36500.0, 36819.0, 36962.8151859239, 31682.366352673278, 32217.35565288634, 33247.66752332446, 33361.0, 33385.499217512246, 25322.240332790047, 25653.615195771705, 27157.185284441497, 27735.564586183173, 27915.581266281428], "unit": "score", "name": "ext.html", "value": 17255.148059637242}, {"lowerIsBetter": false, "replicates": [313.5563178102984, 316.8194129346273, 316.93027533942524, 322.6660406479293, 328.7008821972006, 12609.4325755341, 12996.090273680846, 14923.104613723184, 15330.69338613227, 15872.206389680514, 12634.052446066537, 14709.92645036776, 15137.31882065307, 15674.294656740445, 15702.371905123782, 4830.903381932368, 4938.333325001133, 4955.702657840541, 5101.795928162869, 5111.105556527611, 3378.476336167898, 3488.3197776433603, 5041.798328066891, 5088.872778180538, 5089.389273287192, 5139.383274007125, 5171.922421163686, 5206.505381988705, 5211.088059589557, 5211.218317252405, 5161.096808058574, 5161.200013997836, 5308.761105750251, 5630.183623374629, 5665.688387138705, 5009.774560144766, 5041.8487445376695, 5042.042012017741, 5055.115354812893, 5059.418166910816, 12104.87895121055, 12113.33376664283, 12114.81827772584, 12125.878741212564, 16076.59808504785, 1844.1516902224992, 1859.172668162668, 1863.487540926256, 1916.4059141666128, 1950.3856285270094, 8583.828323433496, 8772.298216142693, 8934.955325223398, 9093.954530227373, 9142.634294628207, 1434.8995570310083, 1734.9392771253072, 1753.1672455583623, 1787.0885848217504, 1807.2228941555127, 49867.75066124683, 50753.238701419505, 52794.736026319624, 54828.45171548273, 57379.426205738244, 8842.921913350357, 9111.088891110836, 9411.05889411067, 9431.481268530297, 9470.431774093577, 12364.134510584352, 12400.75198496043, 12405.13164078524, 12417.19288246261, 12430.12989090773, 6846.623435710984, 6862.0, 6909.861802764017, 6942.7222911084, 6949.93050069503, 6512.088307636935, 6572.309907459648, 6577.177852768404, 6628.4697224221945, 6642.103316052271, 4100.671946244293, 4173.184664670878, 4177.248095342868, 4211.157768446323, 4215.178040282116, 1615.5799492131896, 1672.339425926752, 1677.337451706569, 1736.956576085608, 1766.5230387795223, 372.5678213272591, 859.862422012475, 898.128815049401, 906.6826610686339, 1010.2322235101376, 9452.149306562305, 9557.23542116629, 9732.951335243279, 9808.411495310304, 9862.309638325249, 350.93156834417044, 383.70646455461593, 397.32454826793986, 405.68559366490615, 406.0518688861541, 5390.21841832932, 5520.641158324696, 5572.86067848307, 5630.662160270315, 5635.802746903921, 474112.0, 477068.0, 479102.0, 493307.0, 493599.0, 67831.66084169547, 70393.2960670397, 71462.0, 71680.64159679168, 71772.64113679502, 438.10626322302784, 441.882901031227, 445.06092145572813, 445.08534960655516, 445.48546428874704, 9291.21024712907, 9434.669786557437, 9472.526373681427, 9494.192993595345, 9535.189508891544, 29891.0, 30514.389712206077, 30546.541801872547, 30685.07944761661, 31103.68896311008, 41628.37557436701, 42340.576594233666, 42709.35935960901, 42827.357589636806, 43113.13773724571, 8427.873581896154, 8486.448380855225, 8568.828623427622, 8576.742697719079, 8733.257673097858, 9884.0, 9900.50497475109, 9922.900770992197, 9963.950180249343, 12456.813147802972, 12321.815172772594, 12427.875721242672, 12967.870321296667, 13561.0, 13577.52478663242, 12854.550090747152, 13206.735865282833, 13271.402786874807, 13351.599452016455, 13505.86494135046, 11051.613193538187, 11511.76976460483, 11910.166288359731, 12654.493820247088, 13227.735445291233, 8408.495490270603, 8548.316134709085, 8589.570521473775, 8875.423097498642, 8879.511626860327, 9274.582643780912, 9303.069693030642, 9305.255579553756, 11592.768144636892, 13463.932680336535], "unit": "score", "name": "jquery.html", "value": 7222.553262530167}, {"lowerIsBetter": false, "replicates": [1240.968975775605, 1646.769452276681, 1691.7208660571007, 1727.1795896948943, 1736.730806724958, 5751.309842818857, 7038.964805175973, 7286.854262914739, 7308.6345682715855, 7309.232530584279, 7273.0908636420445, 7428.888566671504, 7435.144958329794, 7435.256474352562, 7446.925530744691, 1720.6300645361246, 1765.3115285038846, 1765.964680706385, 2043.448268967378, 2089.3418573149484, 1766.5495298698813, 2088.112552165331, 2123.182574708733, 2133.9039743211515, 2137.444264491228, 2028.9695654565194, 2061.2991582861823, 2072.9274475393363, 2074.097767471147, 2074.4191626344646, 2077.158750705959, 2102.621528124937, 2104.1478201328487, 2106.09437941685, 2108.50450144216, 2071.606394785001, 2075.2321640992777, 2104.947376315589, 2107.3256557901477, 2107.725995620575, 7299.19708832028, 7340.155882073523, 7342.412606991428, 7355.852882942365, 7359.153697324823, 4249.320108782611, 4328.891777705551, 4330.805113769857, 4348.434703488558, 4362.956370436286, 2735.261479400551, 2749.8762555684843, 2782.4156927045346, 2785.6378670772874, 2804.3549983503704, 879.4327658660128, 886.4636894678691, 891.7993451473432, 903.7966457547066, 914.0402577293814, 9765.658201962968, 9809.21526277896, 9817.312788104835, 9826.16477599405, 9835.45904975226, 3778.6977041837135, 3796.468494410785, 3871.593482684334, 3922.1763429679518, 3935.58676338986, 8501.95749021251, 8512.148785121562, 8520.147985201555, 8524.914750852537, 8543.35924805642, 4245.214635292481, 4275.893102672458, 4291.6566674665955, 4292.012837047497, 4296.0, 3846.1346197105986, 3863.613638636114, 3877.6703980161437, 3890.319194141014, 3894.084890050836, 2946.9410611787644, 3446.8965931022108, 3473.6005359383994, 3523.224890524081, 3526.5062891195253, 979.6767066867917, 1110.7611863449235, 1121.5738019552682, 1125.662301309604, 1133.1557989298026, 990.4206039466849, 990.5790039233297, 1023.7338292044122, 1056.271172890703, 1210.2194084815244, 6801.795946121525, 6842.897356539655, 6847.589144651337, 6865.759698410531, 6872.553284036621, 1043.0, 1048.6591857646142, 1049.5382031905938, 1064.4518073192312, 1068.053542161705, 5272.604554658416, 5347.0, 5349.786008559692, 5352.0366334060245, 5354.384245811703, 8681.350543396735, 8760.255378292917, 8958.014618391971, 8962.372633915693, 8975.506347150838, 8831.337649676172, 8849.380543361904, 8862.980757213003, 8866.157715017063, 8869.113088691209, 6783.898241526381, 6904.27505111956, 6958.686859091353, 6958.860822783516, 7007.054047703495, 6565.803025909039, 6586.769463068769, 6588.374104460068, 6603.471722262304, 6603.900941485786, 7508.699652013858, 7716.922830771845, 7828.45200835936, 7849.254320839511, 7931.524108553274, 7625.351845093007, 7913.0, 7929.365650748042, 7933.1670174630835, 7979.601019949096, 6283.685815709287, 6407.167068281094, 6462.870742585028, 6566.376194261537, 6577.6053436793945, 5757.596968212185, 5971.820845374646, 7174.856502870018, 7225.710971561079, 7240.1311842579225, 6252.09344645033, 6378.489720822416, 6506.154199953976, 6509.218893732783, 6590.242122155822, 6249.875002500015, 6273.278572964167, 6410.5192110592825, 6463.903041454476, 6624.6025238485845, 6338.366163383625, 6495.188101487314, 6548.8362790930605, 6590.143281373391, 6645.435138013323, 5998.370171131968, 6026.186464827192, 6034.336223015377, 6036.969815151072, 6039.214902062704, 5945.672987985529, 6006.939930600638, 6069.2110025696375, 6099.054646529795, 6101.084837274267], "unit": "score", "name": "mootools.html", "value": 4144.729617963786}, {"lowerIsBetter": false, "replicates": [298.30197338228544, 303.1647810282671, 307.4558032282858, 308.0266358307748, 309.7800561601263, 5420.593455490839, 5433.809816656418, 5464.754086066127, 5469.863253418656, 5476.3428388593375, 5358.544523715479, 5361.624686271953, 5366.356037275533, 5367.624266301361, 5370.570354371651, 4194.727342722728, 4194.832206711728, 4198.727082739612, 4199.3910882921955, 4200.516940551845, 4000.2399544086675, 4116.732412393185, 4186.330187170053, 4200.474940632421, 4205.243056249874, 3600.1539638185004, 4007.7194596378267, 4081.0409553754844, 4087.7138600297844, 4089.734167279132, 4033.5764744701823, 4077.0, 4128.0, 4128.60778226068, 4131.008557946101, 3457.861685532576, 3656.9085772855624, 3696.316181506403, 3697.352963231424, 3697.5932647408763, 4980.800767969277, 5110.080185566597, 5126.92309615356, 5159.509846564571, 5240.030594340059, 4745.1695953208055, 4746.715197088151, 4751.002289519205, 4752.358431611723, 4766.4995175506765, 5664.830055098354, 5677.716114194273, 5682.034054210752, 5685.431456854323, 5686.346070201938, 3904.4728961590104, 3908.706846986459, 3909.550401703812, 3910.393888947218, 3913.6869050475893, 5794.304683438015, 5869.471747542699, 5960.910586341209, 5962.224910761616, 5966.642001479881, 4010.5588385277597, 4010.799460026987, 4011.8194681239415, 4012.9197416051516, 4015.8393664253103, 4070.9592904070582, 4073.6944729145434, 4077.327241005201, 4077.571854955246, 4078.2659121358442, 4632.814687412533, 4689.015306785614, 4697.459792123881, 4697.812087516461, 4703.106409782131, 5197.272381866542, 5413.323334583177, 5559.0, 5662.0, 5694.0, 1419.5528408551274, 1435.9497417590335, 1438.129931391514, 1438.7122575484946, 1439.2515891736448, 931.4411353188168, 934.5654270763991, 943.3820847345, 976.9658061967939, 977.0815433492636, 4982.0, 4988.052270068675, 4991.226359914219, 4996.850094497171, 4997.700137991732, 5894.351621321651, 5898.174255604219, 5902.026165682701, 5904.409559044061, 5908.497777688945, 4981.6761910476425, 4986.276989836453, 4989.90020199594, 4994.90010199794, 4995.925061124086, 3096.6903309669306, 3099.860506277223, 3174.5238214268043, 3178.8092714436743, 3181.44324743169, 5603.187537806995, 5617.21359009739, 5623.325200975909, 5627.240322556402, 5628.577856660685, 5798.072308430631, 5918.556108291896, 5943.375945525658, 6120.816375508742, 6131.478824299985, 5557.916631250535, 5587.385387607279, 5596.496315331639, 5602.327720673546, 5612.550995920316, 5936.525077993837, 5940.227770389822, 5944.048952167633, 5946.910796337972, 5948.524118070457, 5656.066748986371, 5724.484796368347, 5743.4256574342235, 5797.4057134288405, 5803.854903627274, 5588.385277619377, 5590.440955904377, 5593.580481463988, 5599.0, 5603.131514615241, 3945.5659877412886, 4001.0, 4002.0, 4005.7796821175116, 4012.217617564547, 5932.436418540232, 5939.07944268639, 5942.821715348547, 5953.58324917269, 5956.315023772148, 5630.690312032878, 5711.114777209539, 5731.111677689964, 5737.885242295048, 5741.971290143522, 5732.455416735404, 5733.71331433435, 5735.569832262514, 5740.39725828782, 5741.0, 5603.859903502445, 5610.270664813548, 5610.85972850682, 5610.915836262541, 5611.57913156523, 5619.662820230799, 5770.076787713946, 5784.421557844182, 5785.913211301918, 5798.449147330997, 5649.12438572022, 5650.943490565206, 5657.236273103243, 5659.236003139524, 5661.207430959751], "unit": "score", "name": "prototype.html", "value": 4244.8700010485845}, {"lowerIsBetter": false, "replicates": [704.0284407517624, 747.7382915979405, 781.156351140768, 790.2808444315674, 794.3327604811958, 10448.529816158281, 10612.78774424512, 10671.253012289133, 10702.78594428113, 10724.517396717147, 11791.823122653168, 11894.226875253124, 11926.284422934608, 11997.700057498567, 12019.939900300486, 613.3314686991179, 625.0031200235617, 626.1859582542698, 774.4462709162948, 793.8690116130831, 790.0479921694345, 790.3242727468019, 795.2167115391335, 795.6578671171394, 795.8527672380599, 822.3544517553721, 828.8508068547659, 830.3979614779297, 830.4228561150003, 830.4353039932844, 646.6378827856392, 654.8592052708667, 805.4040010392326, 818.8976377952756, 823.3413269384469, 608.6104892868568, 609.250621735268, 609.3449541742644, 609.7103875659071, 610.1914962674474, 11058.557657693682, 11098.500567474483, 11103.278286911325, 11110.277831940897, 11133.777324453466, 10748.301360411548, 11156.386398748065, 11181.832272515838, 11363.14776391774, 11890.346030968294, 9424.858627120599, 9453.716388508286, 9548.474833884133, 9598.280128990284, 9688.176504997013, 3220.388126256004, 3226.709596136359, 3242.0, 3282.2286762610765, 3315.419801534722, 36991.0, 37123.443148352795, 37188.07029824276, 37227.62772372269, 37254.81372593147, 8958.641654333884, 9230.400023998418, 9235.584398702074, 9361.531923403803, 9431.0, 15437.691246175014, 15442.922785386001, 15450.227488625524, 15450.304736286895, 15467.5359739208, 6301.558890877594, 6431.0, 6497.935020649733, 6525.0, 6590.176227971504, 3514.61339252682, 3584.301061293023, 3594.0116467971516, 3640.453931910182, 3642.7267954903486, 2637.5648018077186, 2674.6790385153904, 2675.1038402135114, 2679.7454241846995, 2682.745139211772, 468.7539042002908, 469.6313393985773, 471.0602348315065, 471.24130150457734, 471.2436539354287, 559.7033572206736, 564.7599770097692, 578.673049726903, 599.5802937943457, 602.4006113916681, 7246.710131594783, 7401.851962960711, 7438.516496427715, 7480.476366654282, 7500.174980752113, 385.4545817667968, 492.3894370979959, 550.9669369931379, 589.4724221821446, 604.9425304596057, 3530.293941211768, 3615.6745892869244, 3680.595134535199, 3697.4268988306853, 3702.20402613434, 47124.52875471202, 48016.27975580369, 48390.75804620954, 48524.757376212896, 48751.756241218565, 43819.342709859375, 44285.33571996423, 44446.11107777827, 44907.32639010417, 44993.10013799771, 40194.79902600527, 40234.59765402367, 40425.0, 40493.0, 40784.3882341771, 7192.568445893263, 7279.235680253497, 7304.780856574312, 7387.4090072795125, 7410.2219266978345, 29498.262543436587, 29928.102156935325, 30044.24889377783, 30056.69943300539, 30493.932712354963, 35871.103222419646, 35902.820485897406, 35991.64008359883, 36134.4579831308, 39034.80482597569, 9837.458939758382, 10008.299419040597, 10149.086582207341, 10324.690259292232, 10370.844437333597, 11113.333200008025, 11285.153613478858, 11309.208355415041, 11389.487473063566, 11533.653990380302, 10136.543855526372, 10322.690319290434, 10331.070203681706, 10436.634717785144, 10922.0, 10245.231607629308, 10611.151107911193, 10624.468776561296, 10708.89291107079, 10886.891131088905, 10064.547095380873, 10379.377237365783, 10581.259311848096, 10585.472652623434, 10921.945390272998, 8832.251580547283, 8946.284297256074, 9077.546122693706, 9252.306077044383, 9396.342256042011, 8757.868631970652, 9229.630814767603, 9233.58448869789, 9316.94084616788, 9426.57580408897], "unit": "score", "name": "yui.html", "value": 5584.476261522162}], "name": "dromaeo_css", "value": 6210.014786052346}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 110.0, 113.0, 111.0, 101.0, 111.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [160.0, 138.0, 157.0, 163.0, 139.0, 162.0, 158.0, 137.0, 166.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 164.0, 162.0, 164.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 95.0, 72.0, 73.0, 72.0, 99.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 94.0, 94.0, 134.0, 94.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 71.0, 72.0, 72.0, 72.0, 83.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [82.0, 93.0, 83.0, 83.0, 89.0, 86.0, 84.0, 86.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [126.0, 119.0, 124.0, 119.0, 125.0, 119.0, 118.0, 126.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 153.0, 145.0, 144.0, 134.0, 146.0, 144.0, 137.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 72.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.18028927009755], "unit": "score", "name": "Richards", "value": 209.90569199999996}, {"lowerIsBetter": false, "replicates": [185.87360594795538], "unit": "score", "name": "DeltaBlue", "value": 355.71483999999987}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2070.3933747412007], "unit": "score", "name": "RayTrace", "value": 357.41468700000013}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [27135.135135135137], "unit": "score", "name": "RegExp", "value": 33.572156374501965}, {"lowerIsBetter": false, "replicates": [620.7324643078833], "unit": "score", "name": "Splay", "value": 131.28200099999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19628.71352697756}]} 02:53:52 INFO - RETURN: dromaeo_css: 6210.02 02:53:52 INFO - RETURN: kraken: 1521.10 02:53:52 INFO - RETURN: v8_7: 19628.71 02:53:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19628.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6210.02"}}} 02:53:52 INFO - Return code: 0 02:53:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:53:52 INFO - # TBPL SUCCESS # 02:53:52 INFO - Running post-action listener: _resource_record_post_action 02:53:52 INFO - Running post-run listener: _resource_record_post_run 02:53:53 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 12288; Write bytes: 545964032; Read time: 180; Write time: 428168 02:53:53 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227573760; Read time: 0; Write time: 228644 02:53:53 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 12288; Write bytes: 318390272; Read time: 180; Write time: 199524 02:53:53 INFO - Running post-run listener: _upload_blobber_files 02:53:53 INFO - Blob upload gear active. 02:53:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:53:53 INFO - Copying logs to upload dir... 02:53:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.349891 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-20 02:53:51.965403) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 02:53:51.971774) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009981 build_url: 'https://queue.taskcluster.net/v1/task/lMm8zt84TASo385VfHHtAg/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-20 02:53:52.024922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:53:52.025352) ========= 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=d333f129428bd91e5d9d687c000001bd-1450592147.300634-1530200325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 02:53:52.079054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 02:53:52.079831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 02:53:52.080497) ========= ========= Total master_lag: 0.30 =========