builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1464684932.82 results: success (0) buildid: 20160530233024 builduid: 373b31567c274d8c820854ad9ab63d4a revision: 11bba688023eb241c9b1c8c460a53d3679ae41f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:32.820516) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:32.820999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:32.821292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:32.865765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:32.866093) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 01:55:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.4M=0s 2016-05-31 01:55:33 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.008511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.008836) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020893 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.058404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.058772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11bba688023eb241c9b1c8c460a53d3679ae41f0 --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 11bba688023eb241c9b1c8c460a53d3679ae41f0 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 01:55:33,582 truncating revision to first 12 chars 2016-05-31 01:55:33,583 Setting DEBUG logging. 2016-05-31 01:55:33,583 attempt 1/10 2016-05-31 01:55:33,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11bba688023e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 01:55:33,966 unpacking tar archive at: fx-team-11bba688023e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.802924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.803245) ========= script_repo_revision: 11bba688023eb241c9b1c8c460a53d3679ae41f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.803668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.803989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 01:55:33.813570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-31 01:55:33.814374) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:55:34 INFO - MultiFileLogger online at 20160531 01:55:34 in /builds/slave/test 01:55:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:55:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:55:34 INFO - {'append_to_log': False, 01:55:34 INFO - 'base_work_dir': '/builds/slave/test', 01:55:34 INFO - 'blob_upload_branch': 'Fx-Team', 01:55:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:55:34 INFO - 'branch': 'Fx-Team', 01:55:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:55:34 INFO - 'config_files': ('talos/linux_config.py',), 01:55:34 INFO - 'default_actions': ('clobber', 01:55:34 INFO - 'read-buildbot-config', 01:55:34 INFO - 'download-and-extract', 01:55:34 INFO - 'populate-webroot', 01:55:34 INFO - 'create-virtualenv', 01:55:34 INFO - 'install', 01:55:34 INFO - 'run-tests'), 01:55:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:55:34 INFO - 'download_minidump_stackwalk': True, 01:55:34 INFO - 'download_symbols': 'ondemand', 01:55:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:55:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:55:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:55:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:55:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:55:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:55:34 INFO - 'installer_path': 'installer.exe', 01:55:34 INFO - 'log_level': 'info', 01:55:34 INFO - 'log_name': 'talos', 01:55:34 INFO - 'log_to_console': True, 01:55:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:55:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:55:34 INFO - 'opt_config_files': (), 01:55:34 INFO - 'pip_index': False, 01:55:34 INFO - 'sps_profile': False, 01:55:34 INFO - 'sps_profile_interval': 0, 01:55:34 INFO - 'suite': 'dromaeojs', 01:55:34 INFO - 'system_bits': '32', 01:55:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:55:34 INFO - 'title': 'talos-linux64-ix-041', 01:55:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:55:34 INFO - 'use_talos_json': True, 01:55:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:55:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:55:34 INFO - 'work_dir': 'build'} 01:55:34 INFO - ##### 01:55:34 INFO - ##### Running clobber step. 01:55:34 INFO - ##### 01:55:34 INFO - Running pre-action listener: _resource_record_pre_action 01:55:34 INFO - Running main action method: clobber 01:55:34 INFO - rmtree: /builds/slave/test/build 01:55:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:55:34 INFO - Running post-action listener: _resource_record_post_action 01:55:34 INFO - ##### 01:55:34 INFO - ##### Finished clobber step (success) 01:55:34 INFO - ##### 01:55:34 INFO - ##### 01:55:34 INFO - ##### Running read-buildbot-config step. 01:55:34 INFO - ##### 01:55:34 INFO - Running pre-action listener: _resource_record_pre_action 01:55:34 INFO - Running main action method: read_buildbot_config 01:55:34 INFO - Using buildbot properties: 01:55:34 INFO - { 01:55:34 INFO - "project": "", 01:55:34 INFO - "product": "firefox", 01:55:34 INFO - "script_repo_revision": "production", 01:55:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:55:34 INFO - "repository": "", 01:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:55:34 INFO - "buildid": "20160530233024", 01:55:34 INFO - "pgo_build": "True", 01:55:34 INFO - "basedir": "/builds/slave/test", 01:55:34 INFO - "buildnumber": 742, 01:55:34 INFO - "slavename": "talos-linux64-ix-041", 01:55:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:55:34 INFO - "platform": "ubuntu64_hw", 01:55:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:55:34 INFO - "branch": "fx-team", 01:55:34 INFO - "repo_path": "integration/fx-team", 01:55:34 INFO - "revision": "11bba688023eb241c9b1c8c460a53d3679ae41f0", 01:55:34 INFO - "stage_platform": "linux64-pgo", 01:55:34 INFO - "builduid": "373b31567c274d8c820854ad9ab63d4a", 01:55:34 INFO - "slavebuilddir": "test" 01:55:34 INFO - } 01:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:55:34 INFO - Running post-action listener: _resource_record_post_action 01:55:34 INFO - ##### 01:55:34 INFO - ##### Finished read-buildbot-config step (success) 01:55:34 INFO - ##### 01:55:34 INFO - ##### 01:55:34 INFO - ##### Running download-and-extract step. 01:55:34 INFO - ##### 01:55:34 INFO - Running pre-action listener: _resource_record_pre_action 01:55:34 INFO - Running main action method: download_and_extract 01:55:34 INFO - mkdir: /builds/slave/test/build/tests 01:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:34 INFO - https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:55:35 INFO - Downloaded 1361 bytes. 01:55:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:55:35 INFO - Using the following test package requirements: 01:55:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:55:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:55:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'jsshell-linux-x86_64.zip'], 01:55:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:55:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:55:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:55:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:55:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:55:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:55:35 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')]} 01:55:35 INFO - https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:55:36 INFO - Downloaded 24410678 bytes. 01:55:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:55:38 INFO - Return code: 0 01:55:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:38 INFO - https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:55:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:55:41 INFO - Downloaded 24410678 bytes. 01:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:55:42 INFO - Return code: 0 01:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:42 INFO - https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:55:43 INFO - Downloaded 10834055 bytes. 01:55:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:55:43 INFO - Return code: 0 01:55: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')]} 01:55:43 INFO - https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:55:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:55:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:55:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:55:45 INFO - Downloaded 58945444 bytes. 01:55:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:55:45 INFO - mkdir: /builds/slave/test/properties 01:55:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:45 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:45 INFO - Contents: 01:55:45 INFO - build_url:https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:55:46 INFO - Running post-action listener: _resource_record_post_action 01:55:46 INFO - Running post-action listener: set_extra_try_arguments 01:55:46 INFO - ##### 01:55:46 INFO - ##### Finished download-and-extract step (success) 01:55:46 INFO - ##### 01:55:46 INFO - ##### 01:55:46 INFO - ##### Running populate-webroot step. 01:55:46 INFO - ##### 01:55:46 INFO - Running pre-action listener: _resource_record_pre_action 01:55:46 INFO - Running main action method: populate_webroot 01:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:46 INFO - '--tppagecycles', 01:55:46 INFO - '7'], 01:55:46 INFO - 'tests': ['tsvgm']}}, 01:55:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:55:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:55:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['damp', 'tps']}, 01:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['damp', 'tps']}, 01:55:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['dromaeo_dom']}, 01:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tsvgx', 01:55:46 INFO - 'tsvgr_opacity', 01:55:46 INFO - 'tart', 01:55:46 INFO - 'tscrollx', 01:55:46 INFO - 'cart']}, 01:55:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:55:46 INFO - 'tsvgr_opacity', 01:55:46 INFO - 'tart', 01:55:46 INFO - 'tscrollx', 01:55:46 INFO - 'cart']}, 01:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tp5o']}, 01:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['tp5o']}, 01:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s', 01:55:46 INFO - '--xperf_path', 01:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:46 INFO - 'tests': ['tp5n']}, 01:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--xperf_path', 01:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:46 INFO - 'tests': ['tp5n']}}, 01:55:46 INFO - 'talos.zip': {'path': '', 01:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:46 INFO - Running post-action listener: _resource_record_post_action 01:55:46 INFO - ##### 01:55:46 INFO - ##### Finished populate-webroot step (success) 01:55:46 INFO - ##### 01:55:46 INFO - ##### 01:55:46 INFO - ##### Running create-virtualenv step. 01:55:46 INFO - ##### 01:55:46 INFO - Running pre-action listener: _resource_record_pre_action 01:55:46 INFO - Running main action method: create_virtualenv 01:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:46 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 01:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:46 INFO - Using real prefix '/usr' 01:55:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:48 INFO - Installing pip.................done. 01:55:48 INFO - Return code: 0 01:55:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:55:48 INFO - Using env: {'DISPLAY': ':0', 01:55:48 INFO - 'HOME': '/home/cltbld', 01:55:48 INFO - 'LANG': 'en_US.UTF-8', 01:55:48 INFO - 'LANGUAGE': 'en_US:en', 01:55:48 INFO - 'LOGNAME': 'cltbld', 01:55:48 INFO - 'MAIL': '/var/mail/cltbld', 01:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:48 INFO - 'MOZ_NO_REMOTE': '1', 01:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:48 INFO - 'NO_EM_RESTART': '1', 01:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:48 INFO - 'PWD': '/builds/slave/test', 01:55:48 INFO - 'SHELL': '/bin/bash', 01:55:48 INFO - 'SHLVL': '1', 01:55:48 INFO - 'TERM': 'linux', 01:55:48 INFO - 'TMOUT': '86400', 01:55:48 INFO - 'USER': 'cltbld', 01:55:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:48 INFO - '_': '/tools/buildbot/bin/python'} 01:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:48 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 01:55:48 INFO - Cleaning up... 01:55:48 INFO - Return code: 0 01:55:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 01:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 01:55:48 INFO - Using env: {'DISPLAY': ':0', 01:55:48 INFO - 'HOME': '/home/cltbld', 01:55:48 INFO - 'LANG': 'en_US.UTF-8', 01:55:48 INFO - 'LANGUAGE': 'en_US:en', 01:55:48 INFO - 'LOGNAME': 'cltbld', 01:55:48 INFO - 'MAIL': '/var/mail/cltbld', 01:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:48 INFO - 'MOZ_NO_REMOTE': '1', 01:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:48 INFO - 'NO_EM_RESTART': '1', 01:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:48 INFO - 'PWD': '/builds/slave/test', 01:55:48 INFO - 'SHELL': '/bin/bash', 01:55:48 INFO - 'SHLVL': '1', 01:55:48 INFO - 'TERM': 'linux', 01:55:48 INFO - 'TMOUT': '86400', 01:55:48 INFO - 'USER': 'cltbld', 01:55:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:48 INFO - '_': '/tools/buildbot/bin/python'} 01:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:49 INFO - Downloading/unpacking psutil>=3.1.1 01:55:49 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 01:55:49 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 01:55:49 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 01:55:49 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 01:55:49 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 01:55:49 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 01:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:52 INFO - Installing collected packages: psutil 01:55:52 INFO - Running setup.py install for psutil 01:55:52 INFO - building 'psutil._psutil_linux' extension 01:55:52 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 01:55:52 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 01:55:52 INFO - building 'psutil._psutil_posix' extension 01:55:52 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 01:55:52 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 01:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:52 INFO - Successfully installed psutil 01:55:52 INFO - Cleaning up... 01:55:52 INFO - Return code: 0 01:55:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:55: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')]} 01:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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')]} 01:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 01:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 01:55:52 INFO - Using env: {'DISPLAY': ':0', 01:55:52 INFO - 'HOME': '/home/cltbld', 01:55:52 INFO - 'LANG': 'en_US.UTF-8', 01:55:52 INFO - 'LANGUAGE': 'en_US:en', 01:55:52 INFO - 'LOGNAME': 'cltbld', 01:55:52 INFO - 'MAIL': '/var/mail/cltbld', 01:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:52 INFO - 'MOZ_NO_REMOTE': '1', 01:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:52 INFO - 'NO_EM_RESTART': '1', 01:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:52 INFO - 'PWD': '/builds/slave/test', 01:55:52 INFO - 'SHELL': '/bin/bash', 01:55:52 INFO - 'SHLVL': '1', 01:55:52 INFO - 'TERM': 'linux', 01:55:52 INFO - 'TMOUT': '86400', 01:55:52 INFO - 'USER': 'cltbld', 01:55:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:52 INFO - '_': '/tools/buildbot/bin/python'} 01:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:55:55 INFO - Installing collected packages: mozsystemmonitor 01:55:55 INFO - Running setup.py install for mozsystemmonitor 01:55:55 INFO - Successfully installed mozsystemmonitor 01:55:55 INFO - Cleaning up... 01:55:55 INFO - Return code: 0 01:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:55:55 INFO - Using env: {'DISPLAY': ':0', 01:55:55 INFO - 'HOME': '/home/cltbld', 01:55:55 INFO - 'LANG': 'en_US.UTF-8', 01:55:55 INFO - 'LANGUAGE': 'en_US:en', 01:55:55 INFO - 'LOGNAME': 'cltbld', 01:55:55 INFO - 'MAIL': '/var/mail/cltbld', 01:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:55 INFO - 'MOZ_NO_REMOTE': '1', 01:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:55 INFO - 'NO_EM_RESTART': '1', 01:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:55 INFO - 'PWD': '/builds/slave/test', 01:55:55 INFO - 'SHELL': '/bin/bash', 01:55:55 INFO - 'SHLVL': '1', 01:55:55 INFO - 'TERM': 'linux', 01:55:55 INFO - 'TMOUT': '86400', 01:55:55 INFO - 'USER': 'cltbld', 01:55:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:55 INFO - '_': '/tools/buildbot/bin/python'} 01:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:55 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 01:55:55 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 01:55:55 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 01:55:55 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 01:55:55 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 01:55:55 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 01:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:57 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 01:55:58 INFO - Downloading docopt-0.6.1.tar.gz 01:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:58 INFO - Running setup.py install for blobuploader 01:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:58 INFO - Running setup.py install for requests 01:55:58 INFO - Running setup.py install for docopt 01:55:58 INFO - Successfully installed blobuploader requests docopt 01:55:58 INFO - Cleaning up... 01:55:58 INFO - Return code: 0 01:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 01:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 01:55:58 INFO - Using env: {'DISPLAY': ':0', 01:55:58 INFO - 'HOME': '/home/cltbld', 01:55:58 INFO - 'LANG': 'en_US.UTF-8', 01:55:58 INFO - 'LANGUAGE': 'en_US:en', 01:55:58 INFO - 'LOGNAME': 'cltbld', 01:55:58 INFO - 'MAIL': '/var/mail/cltbld', 01:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:58 INFO - 'MOZ_NO_REMOTE': '1', 01:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:58 INFO - 'NO_EM_RESTART': '1', 01:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:58 INFO - 'PWD': '/builds/slave/test', 01:55:58 INFO - 'SHELL': '/bin/bash', 01:55:58 INFO - 'SHLVL': '1', 01:55:58 INFO - 'TERM': 'linux', 01:55:58 INFO - 'TMOUT': '86400', 01:55:58 INFO - 'USER': 'cltbld', 01:55:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:58 INFO - '_': '/tools/buildbot/bin/python'} 01:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:58 INFO - Running setup.py (path:/tmp/pip-w83qtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:58 INFO - Running setup.py (path:/tmp/pip-Y7A4Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:59 INFO - Running setup.py (path:/tmp/pip-7FejUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:59 INFO - Running setup.py (path:/tmp/pip-JHN6MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:59 INFO - Running setup.py (path:/tmp/pip-aoyPCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:59 INFO - Running setup.py (path:/tmp/pip-Cf4ekT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:59 INFO - Running setup.py (path:/tmp/pip-npvZgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:59 INFO - Running setup.py (path:/tmp/pip-Ihx8p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:59 INFO - Running setup.py (path:/tmp/pip-aIPVqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:59 INFO - Running setup.py (path:/tmp/pip-FpzmV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:59 INFO - Running setup.py (path:/tmp/pip-6yleeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:59 INFO - Running setup.py (path:/tmp/pip-ex1JFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:59 INFO - Running setup.py (path:/tmp/pip-0QfTDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:59 INFO - Running setup.py (path:/tmp/pip-kI08vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:59 INFO - Running setup.py (path:/tmp/pip-DrHWg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:59 INFO - Running setup.py (path:/tmp/pip-pOVbST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:00 INFO - Running setup.py (path:/tmp/pip-4vLgIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:00 INFO - Running setup.py install for manifestparser 01:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Running setup.py install for mozcrash 01:56:00 INFO - Running setup.py install for mozdebug 01:56:00 INFO - Running setup.py install for mozdevice 01:56:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Running setup.py install for mozfile 01:56:00 INFO - Running setup.py install for mozhttpd 01:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Running setup.py install for mozinfo 01:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Running setup.py install for mozInstall 01:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:00 INFO - Running setup.py install for mozleak 01:56:01 INFO - Running setup.py install for mozlog 01:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Running setup.py install for moznetwork 01:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Running setup.py install for mozprocess 01:56:01 INFO - Running setup.py install for mozprofile 01:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Running setup.py install for mozrunner 01:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Running setup.py install for mozscreenshot 01:56:01 INFO - Running setup.py install for moztest 01:56:01 INFO - Running setup.py install for mozversion 01:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:01 INFO - Cleaning up... 01:56:01 INFO - Return code: 0 01:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:56:01 INFO - Using env: {'DISPLAY': ':0', 01:56:01 INFO - 'HOME': '/home/cltbld', 01:56:01 INFO - 'LANG': 'en_US.UTF-8', 01:56:01 INFO - 'LANGUAGE': 'en_US:en', 01:56:01 INFO - 'LOGNAME': 'cltbld', 01:56:01 INFO - 'MAIL': '/var/mail/cltbld', 01:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:01 INFO - 'MOZ_NO_REMOTE': '1', 01:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:01 INFO - 'NO_EM_RESTART': '1', 01:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:01 INFO - 'PWD': '/builds/slave/test', 01:56:01 INFO - 'SHELL': '/bin/bash', 01:56:01 INFO - 'SHLVL': '1', 01:56:01 INFO - 'TERM': 'linux', 01:56:01 INFO - 'TMOUT': '86400', 01:56:01 INFO - 'USER': 'cltbld', 01:56:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:01 INFO - '_': '/tools/buildbot/bin/python'} 01:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:02 INFO - Running setup.py (path:/tmp/pip-DEIqLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:02 INFO - Running setup.py (path:/tmp/pip-08jVr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:02 INFO - Running setup.py (path:/tmp/pip-Xbjj_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:02 INFO - Running setup.py (path:/tmp/pip-KPvXCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:02 INFO - Running setup.py (path:/tmp/pip-2gczLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:02 INFO - Running setup.py (path:/tmp/pip-cHe62R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:02 INFO - Running setup.py (path:/tmp/pip-E3zrke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:02 INFO - Running setup.py (path:/tmp/pip-A4_7NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:02 INFO - Running setup.py (path:/tmp/pip-jFdDgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:02 INFO - Running setup.py (path:/tmp/pip-aHQGFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:02 INFO - Running setup.py (path:/tmp/pip-hwRnth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:02 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)) 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:02 INFO - Running setup.py (path:/tmp/pip-8wr6Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:03 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)) 01:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:03 INFO - Running setup.py (path:/tmp/pip-0AaC6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 01:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:03 INFO - Running setup.py (path:/tmp/pip-2KQIk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:03 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)) 01:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:03 INFO - Running setup.py (path:/tmp/pip-ook1oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:03 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)) 01:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:03 INFO - Running setup.py (path:/tmp/pip-yWdAJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:03 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)) 01:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:03 INFO - Running setup.py (path:/tmp/pip-Jdlks_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:03 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)) 01:56:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:03 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)) 01:56:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:05 INFO - Downloading blessings-1.6.tar.gz 01:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:05 INFO - Installing collected packages: blessings 01:56:05 INFO - Running setup.py install for blessings 01:56:05 INFO - Successfully installed blessings 01:56:05 INFO - Cleaning up... 01:56:05 INFO - Return code: 0 01:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:05 INFO - Reading from file tmpfile_stdout 01:56:05 INFO - Current package versions: 01:56:05 INFO - argparse == 1.2.1 01:56:05 INFO - blessings == 1.6 01:56:05 INFO - blobuploader == 1.2.4 01:56:05 INFO - docopt == 0.6.1 01:56:05 INFO - manifestparser == 1.1 01:56:05 INFO - mozInstall == 1.12 01:56:05 INFO - mozcrash == 0.17 01:56:05 INFO - mozdebug == 0.1 01:56:05 INFO - mozdevice == 0.48 01:56:05 INFO - mozfile == 1.2 01:56:05 INFO - mozhttpd == 0.7 01:56:05 INFO - mozinfo == 0.9 01:56:05 INFO - mozleak == 0.1 01:56:05 INFO - mozlog == 3.2 01:56:05 INFO - moznetwork == 0.27 01:56:05 INFO - mozprocess == 0.22 01:56:05 INFO - mozprofile == 0.28 01:56:05 INFO - mozrunner == 6.11 01:56:05 INFO - mozscreenshot == 0.1 01:56:05 INFO - mozsystemmonitor == 0.3 01:56:05 INFO - moztest == 0.7 01:56:05 INFO - mozversion == 1.4 01:56:05 INFO - psutil == 3.1.1 01:56:05 INFO - requests == 1.2.3 01:56:05 INFO - wsgiref == 0.1.2 01:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:56:05 INFO - Using env: {'DISPLAY': ':0', 01:56:05 INFO - 'HOME': '/home/cltbld', 01:56:05 INFO - 'LANG': 'en_US.UTF-8', 01:56:05 INFO - 'LANGUAGE': 'en_US:en', 01:56:05 INFO - 'LOGNAME': 'cltbld', 01:56:05 INFO - 'MAIL': '/var/mail/cltbld', 01:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:05 INFO - 'MOZ_NO_REMOTE': '1', 01:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:05 INFO - 'NO_EM_RESTART': '1', 01:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:05 INFO - 'PWD': '/builds/slave/test', 01:56:05 INFO - 'SHELL': '/bin/bash', 01:56:05 INFO - 'SHLVL': '1', 01:56:05 INFO - 'TERM': 'linux', 01:56:05 INFO - 'TMOUT': '86400', 01:56:05 INFO - 'USER': 'cltbld', 01:56:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:05 INFO - '_': '/tools/buildbot/bin/python'} 01:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:56:05 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 2)) 01:56:05 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 3)) 01:56:05 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 4)) 01:56:05 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 5)) 01:56:05 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 6)) 01:56:05 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 7)) 01:56:05 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 8)) 01:56:05 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 9)) 01:56:05 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:56:05 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 4)) 01:56:05 INFO - Cleaning up... 01:56:05 INFO - Return code: 0 01:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:56:05 INFO - Using env: {'DISPLAY': ':0', 01:56:05 INFO - 'HOME': '/home/cltbld', 01:56:05 INFO - 'LANG': 'en_US.UTF-8', 01:56:05 INFO - 'LANGUAGE': 'en_US:en', 01:56:05 INFO - 'LOGNAME': 'cltbld', 01:56:05 INFO - 'MAIL': '/var/mail/cltbld', 01:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:05 INFO - 'MOZ_NO_REMOTE': '1', 01:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:05 INFO - 'NO_EM_RESTART': '1', 01:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:05 INFO - 'PWD': '/builds/slave/test', 01:56:05 INFO - 'SHELL': '/bin/bash', 01:56:05 INFO - 'SHLVL': '1', 01:56:05 INFO - 'TERM': 'linux', 01:56:05 INFO - 'TMOUT': '86400', 01:56:05 INFO - 'USER': 'cltbld', 01:56:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:05 INFO - '_': '/tools/buildbot/bin/python'} 01:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:06 INFO - Downloading/unpacking jsonschema 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:56:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:56:08 INFO - warning: no files found matching '*.txt' 01:56:08 INFO - no previously-included directories found matching 'build' 01:56:08 INFO - no previously-included directories found matching 'dist' 01:56:08 INFO - no previously-included directories found matching '.git*' 01:56:08 INFO - Installing collected packages: jsonschema, functools32 01:56:08 INFO - Running setup.py install for functools32 01:56:08 INFO - warning: no files found matching '*.txt' 01:56:08 INFO - no previously-included directories found matching 'build' 01:56:08 INFO - no previously-included directories found matching 'dist' 01:56:08 INFO - no previously-included directories found matching '.git*' 01:56:08 INFO - Successfully installed jsonschema functools32 01:56:08 INFO - Cleaning up... 01:56:08 INFO - Return code: 0 01:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f89a42cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', '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 01:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 01:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 01:56:08 INFO - Using env: {'DISPLAY': ':0', 01:56:08 INFO - 'HOME': '/home/cltbld', 01:56:08 INFO - 'LANG': 'en_US.UTF-8', 01:56:08 INFO - 'LANGUAGE': 'en_US:en', 01:56:08 INFO - 'LOGNAME': 'cltbld', 01:56:08 INFO - 'MAIL': '/var/mail/cltbld', 01:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:08 INFO - 'MOZ_NO_REMOTE': '1', 01:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:08 INFO - 'NO_EM_RESTART': '1', 01:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:08 INFO - 'PWD': '/builds/slave/test', 01:56:08 INFO - 'SHELL': '/bin/bash', 01:56:08 INFO - 'SHLVL': '1', 01:56:08 INFO - 'TERM': 'linux', 01:56:08 INFO - 'TMOUT': '86400', 01:56:08 INFO - 'USER': 'cltbld', 01:56:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:08 INFO - '_': '/tools/buildbot/bin/python'} 01:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:08 INFO - Downloading/unpacking flake8 01:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:56:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:10 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 01:56:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56: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 01:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:11 INFO - no previously-included directories found matching 'docs/_build' 01:56:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:56:11 INFO - Running setup.py install for pep8 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:11 INFO - no previously-included directories found matching 'docs/_build' 01:56:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:56:11 INFO - Cleaning up... 01:56:11 INFO - Return code: 0 01:56:11 INFO - Running post-action listener: _resource_record_post_action 01:56:11 INFO - Running post-action listener: _start_resource_monitoring 01:56:11 INFO - Starting resource monitoring. 01:56:11 INFO - ##### 01:56:11 INFO - ##### Finished create-virtualenv step (success) 01:56:11 INFO - ##### 01:56:11 INFO - ##### 01:56:11 INFO - ##### Running install step. 01:56:11 INFO - ##### 01:56:11 INFO - Running pre-action listener: _resource_record_pre_action 01:56:11 INFO - Running main action method: install 01:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:11 INFO - Reading from file tmpfile_stdout 01:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 01:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:56:11 INFO - Reading from file tmpfile_stdout 01:56:11 INFO - Output received: 01:56:11 INFO - Usage: mozinstall [options] installer 01:56:11 INFO - Options: 01:56:11 INFO - -h, --help show this help message and exit 01:56:11 INFO - -d DEST, --destination=DEST 01:56:11 INFO - Directory to install application into. [default: 01:56:11 INFO - "/builds/slave/test"] 01:56:11 INFO - --app=APP Application being installed. [default: firefox] 01:56:11 INFO - mkdir: /builds/slave/test/build/application 01:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:56:28 INFO - Reading from file tmpfile_stdout 01:56:28 INFO - Output received: 01:56:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:56:28 INFO - Running post-action listener: _resource_record_post_action 01:56:28 INFO - ##### 01:56:28 INFO - ##### Finished install step (success) 01:56:28 INFO - ##### 01:56:28 INFO - ##### 01:56:28 INFO - ##### Running run-tests step. 01:56:28 INFO - ##### 01:56:28 INFO - Running pre-action listener: _resource_record_pre_action 01:56:28 INFO - Running main action method: run_tests 01:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:28 INFO - Python 2.7.3 01:56:28 INFO - Return code: 0 01:56:28 INFO - grabbing minidump binary from tooltool 01:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:28 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb9c0>, '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 0x24cc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ccd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:28 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 01:56:28 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 01:56:28 INFO - Calling ['/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'] with output_timeout 600 01:56:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:28 INFO - Return code: 0 01:56:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:56:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:56:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:56:29 INFO - Return code: 0 01:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:56:29 INFO - Using env: {'DISPLAY': ':0', 01:56:29 INFO - 'HOME': '/home/cltbld', 01:56:29 INFO - 'LANG': 'en_US.UTF-8', 01:56:29 INFO - 'LANGUAGE': 'en_US:en', 01:56:29 INFO - 'LOGNAME': 'cltbld', 01:56:29 INFO - 'MAIL': '/var/mail/cltbld', 01:56:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:29 INFO - 'MOZ_NO_REMOTE': '1', 01:56:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:29 INFO - 'NO_EM_RESTART': '1', 01:56:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:29 INFO - 'PWD': '/builds/slave/test', 01:56:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:29 INFO - 'SHELL': '/bin/bash', 01:56:29 INFO - 'SHLVL': '1', 01:56:29 INFO - 'TERM': 'linux', 01:56:29 INFO - 'TMOUT': '86400', 01:56:29 INFO - 'USER': 'cltbld', 01:56:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701', 01:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:29 INFO - '_': '/tools/buildbot/bin/python'} 01:56:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:56:29 INFO - mozversion application_buildid: 20160530233024 01:56:29 INFO - mozversion application_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 01:56:29 INFO - mozversion application_display_name: Nightly 01:56:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:29 INFO - mozversion application_name: Firefox 01:56:29 INFO - mozversion application_remotingname: firefox 01:56:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:56:29 INFO - mozversion application_vendor: Mozilla 01:56:29 INFO - mozversion application_version: 49.0a1 01:56:29 INFO - mozversion platform_buildid: 20160530233024 01:56:29 INFO - mozversion platform_changeset: 11bba688023eb241c9b1c8c460a53d3679ae41f0 01:56:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:29 INFO - mozversion platform_version: 49.0a1 01:56:29 INFO - using testdate: 1464684989 01:56:29 INFO - actual date: 1464684989 01:56:29 INFO - starting webserver on 'localhost:50101' 01:56:29 INFO - SUITE-START | Running 2 tests 01:56:29 INFO - TEST-START | dromaeo_css 01:56:29 INFO - operating with platform_type : linux_ 01:56:29 INFO - Initialising browser for dromaeo_css test... 01:56:29 INFO - TEST-INFO | started process 22257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpfdVo/profile http://localhost:50101/getInfo.html) 01:56:34 INFO - PROCESS | 22257 | __metrics Screen width/height:1600/1200 01:56:34 INFO - PROCESS | 22257 | colorDepth:24 01:56:34 INFO - PROCESS | 22257 | Browser inner width/height: 1024/697 01:56:34 INFO - PROCESS | 22257 | __metrics 01:56:35 ERROR - PROCESS | 22257 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:56:36 INFO - TEST-INFO | 22257: exit 0 01:56:36 INFO - Browser initialized. 01:56:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:56:36 INFO - TEST-INFO | started process 22341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpfdVo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:48 INFO - PROCESS | 22341 | RSS: Main: 155893760 01:56:48 INFO - PROCESS | 22341 | 01:57:39 INFO - PROCESS | 22341 | 1464685059532 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] 01:59:47 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50101/tests/dromaeo/cssquery-ext.html) 01:59:48 INFO - PROCESS | 22341 | RSS: Main: 264450048 01:59:48 INFO - PROCESS | 22341 | 02:02:50 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-ext.html (next: http://localhost:50101/tests/dromaeo/cssquery-jquery.html) 02:02:51 INFO - PROCESS | 22341 | RSS: Main: 243261440 02:02:51 INFO - PROCESS | 22341 | 02:05:53 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50101/tests/dromaeo/cssquery-mootools.html) 02:05:54 INFO - PROCESS | 22341 | RSS: Main: 243077120 02:05:54 INFO - PROCESS | 22341 | 02:08:56 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50101/tests/dromaeo/cssquery-prototype.html) 02:08:56 INFO - PROCESS | 22341 | RSS: Main: 235008000 02:08:56 INFO - PROCESS | 22341 | 02:11:59 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50101/tests/dromaeo/cssquery-yui.html) 02:12:00 INFO - PROCESS | 22341 | RSS: Main: 225656832 02:12:00 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | Cycle 1(1): loaded http://localhost:50101/tests/dromaeo/cssquery-yui.html (next: http://localhost:50101/tests/dromaeo/cssquery-dojo.html) 02:15:03 INFO - PROCESS | 22341 | RSS: Main: 274567168 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | __start_tp_report 02:15:03 INFO - PROCESS | 22341 | _x_x_mozilla_page_load 02:15:03 INFO - PROCESS | 22341 | _x_x_mozilla_page_load_details 02:15:03 INFO - PROCESS | 22341 | |i|pagename|runs| 02:15:03 INFO - PROCESS | 22341 | |0;dojo.html;3110.720035196833;3151.432742106421;3164.8259345735974;3201.4397480440916;3216.8713251469944;5297.178937264721;5365.570754339653;5499.175123731437;5536.640118392307;5576.665400075994;5377.973110134444;5423.240746295512;5454.863628409292;5466.972665136679;5481.342238931324;4857;4911.115999120157;4936.777844996984;4942.703437793726;5106.361704786902;4994.87512812179;5022.372203474566;5058.165402708567;5079.339685840836;5085.949140508585;4761.738104404257;4823.083614113307;4851.830185943492;4860.3195552622665;4884.731339776311;4881.1213981483315;4889.706617602919;4944.505549445063;4961.5534601886;5004.749762511896;4829.299751536043;4922.335484709554;4940.28365886948;4943.802247910079;4956.083124621957;5365.3293338332705;5435.83692489226;5442.782288708447;5518.19986102017;5539.058360078796;5959.463648271676;5972.761089556412;5991.730372133265;5992.820215393545;5996.940030599681;5717.085266357404;5815.244018277639;5845.853853653693;5933.554983376264;5948.940510594882;5516.117421212587;5518.889622207614;5522;5556.16657501374;5568.303962004749;6035.969820150871;6048.274207095089;6068.362821903725;6068.514518838482;6068.878622427526;5507.228987941691;5625.887482250332;5733.111367738007;5744.4829965303325;5791.044477661138;5865.706714664249;5868.471837534642;5875.059990401515;5879.647221166658;5891.351951285355;5780.855478613068;5784.623999440023;5840.3575606683235;5845.210896528999;5849.3858144894175;5539.556835453154;5745.195672605839;5822.883542329129;5869.295684517885;5921.348651648315;4399.780010999437;4402.537733537996;4407.845725399596;4407.933880991788;4443.6889417741095;3822.3502004659276;3902.804859757001;3945.822437990297;3962.8612998544913;3989.880303590897;5496.148097044965;5581.581381396411;5596.104623260258;5603.411641777555;5631.577631677641;5967.313758917693;5968.46283834457;5974.492168165754;5979.282486101695;6033.668148251888;5411.269478620336;5529.640573362719;5609.158626206102;5617.943820561742;5630.662160270397;4986.750662466862;5045.949540504548;5052.72210028452;5055.620828437882;5091.3381260436645;6141;6157.815265542041;6160.722767475474;6164.229471316085;6166.9383306167265;5621.831345059655;5816.76732930678;5816.941830581809;5948.315943666534;5961.672108033927;6023.909641355471;6037.335893051673;6040.607360521552;6042.1843051187525;6050.42520960508;5696;5729.570282228766;5734.311882574118;5753.798617048383;5761.251037365116;5699.743511542073;5803.82588522345;5816.5055970243;5820.330661973927;5856.619319744203;5765.481106700249;5789.91315130265;5801.76792928295;5805.361410244954;5805.883882322245;5694.800681976111;5742.885142297047;5760.711964401679;5761.251037365116;5776.7400466979925;5457.781688732406;5558.499735023867;5588.050031494575;5619.606627536034;5673.716314184192;5797.739101740516;5802.912956305574;5854.590178687451;5857.26784151981;5857.58996870215;5476.424975377688;5644.604877658525;5693.3168019837885;5695.772169113189;5736.770529178953 02:15:03 INFO - PROCESS | 22341 | |1;ext.html;571.4314257313971;625.0780099353454;625.5339771869958;643.5527308520581;646.9644169570674;32939.83530082349;33501.32997340052;45093.774531127296;45998.54001459984;46013.53986460134;43609.78195109028;46820.297695534595;47041.29438058432;47146;47171.52828471714;8760.51817150055;8965.32760042996;8968.46189228645;8974;8983.865242021375;8742.344324175681;8883.866741998876;8886.511241881693;8888.555572221396;8895.644174233055;8861.11388861112;8881.911180888206;8943.105689431037;8943.865842012376;8947;8891.822163556724;8929.06244844295;8937;8937.419067760575;8941.552922353889;8663.956680216621;8673.176048275403;8679.652813887436;8690.782730431727;8692.478451292942;43030.139397212195;43483.56516434827;43515.34726979098;43554;43585.34621980673;3440.8795692150657;3603.1172362771026;3642.1258897864586;3729.4219395993664;3986;32272.838635806904;32848.83575582131;33161.83419082913;34116.147096322544;34218.31563368744;4283.336082907154;4295.226859165349;4322.870313890557;4349.782510874444;4481.64146868253;360199;361099;361281;361288;361865;62396;62428.375716243165;62845.371546283954;63181;63249.36750632435;35991.10022249465;36799.03213066202;36858.078548036516;38396.42405363922;66091;16515;16538.421155259508;16646.417375391804;16713;16732.079735614658;12467.438965246585;12558.560450384193;12560.874391255971;12564.937175314066;12579.685507862378;20052;20170.394888153085;20227.595448090957;20248.493787655425;20364.389068327975;6959.269276725972;7141.714811186912;7246.347828695442;7325.6337183141695;7412.813949768011;959.7840485890758;1031.2832581356035;1053.373242920461;1118.608487029533;1190.7142285851507;32704.34591308208;32919.83540082284;33040.50439243413;33350.49974250388;33581.32837343239;1128.9322640641587;1133.1218305812897;1184.7215904262664;1190.357207108152;1210.074293165729;17177.914110429367;17380;17460.214290356966;17481.650366992588;17485.213165407586;500534;502346;503350;504844;510205;59158;60465;60673;60700.39299607036;60724.39275607187;1270.6124631987147;1332.80007998799;1347.636138242669;1376.827896512936;1392.3455975691409;32741.398446171377;33676.49485257772;33728.49407258844;33771;34828.30343393169;51835.74082129565;55155.72422138024;56853;56885.715571421875;62628.373716264075;530635;531942;535256;536791;538677;36219;37200.62799371972;38270;46108.53891461177;46693.29960050534;46262.53737462583;49710.25434618411;50192.74903625459;50739;51148.74425627848;40759.796201018806;42795;43260.567394326914;43818.780906095264;44601;42604.78697606492;42755;43192.35211471893;43245.78377108094;43600.34599481074;41265.58734412617;41702;43042.13915721731;43182.352264715424;43190.56809431865;34324.828375857964;37279;37847.10764461821;38021.80989095037;38432.231355372176;28076.85961570179;28371.43257134887;28385.716142838308;28420.289492762848;28441.573376398956 02:15:03 INFO - PROCESS | 22341 | |2;jquery.html;388.4270700716444;389.1205874723125;392.3722044728437;395.5451231084253;414.54607205110415;13856.38656174998;16302.347906083773;17839.732404013936;19377.806221937775;19399.12703928323;17783.64432711345;18035.188416521254;18124.36564720235;18405.355812546564;18431.90784046081;5602.85992850179;5733.942660573403;5771.192033115367;5787.913181302284;5797.188393624896;3858.84564617415;5661.405552416999;5712.22884910538;6116.7553297868035;6419.64691941943;6432.646204458753;6472.288048314682;6490.4807615390655;6501.862174119534;6509;6224.906626400608;6458.031295305695;6466.418022377985;6472;6475.190601174853;5450.482204190595;5655.575831812631;5656.038473459522;5660.3490598581275;5686.772529098831;21336.359909202747;21890.12439502418;22031.779682203134;22095.668564971376;22162.88918555397;2301.7122859642545;2422.8909699063584;2511.4474815540552;2741.7669498092687;2754.560687347409;9358.15776580111;9719.36824106438;9904.405735655884;10031.996800319983;14284.285785710777;1807.4455967867623;1872.87826291292;1908.1794828223858;1943.3399602385687;1955.511122219445;57801.42198578044;66061.33938660599;66529.66735166294;67694.66152669255;72406.63796681036;7835.216478352119;8263.834723305501;8326.333893288522;8874.423162494417;10138.695839124837;11152.888471115184;11245;11254;11269.71825704364;11288.153388495732;7302.853942921218;7388.408927285805;7431.665575049135;7479.813004674927;7604;7769.339606133542;7776.950111734956;7959.641816118288;8158.469699469515;8158.796030099295;3504.491848681927;3580.7135429165605;3638.890833274953;3681.3005528949416;3750;1677.991610041942;1757.77148970633;1766.7084930986243;1807.3854889337688;1808.7171783213425;986.4820968991194;994.2294721590825;1024.109025148126;1051.5793682526898;1061.2571200159919;18018.278834587;18801.80369337216;18825.717614235797;18927.621447571248;19390.4182874514;956.732329663199;1000.573608998191;1007.3502590829021;1013.381837079381;1063.1335461598926;10322.812876519147;10434.530446129942;10619;10705.982931621484;10792.352458852494;233149;235212;236122;236251;444876;88094;91715;93152.82116482005;93254;93680.0972906165;1015;1030.07808011829;1042.593388578455;1051.81593221186;1051.9789604207872;16667.91666041662;16919.238634261736;17141.14294285256;17296.308147674456;17596.38412655551;40148.19703605853;40540.39189412102;40787.796061020694;42641.57358426376;42691.57308427;57168;58152.4184758147;58955.115673264074;59185.40814591799;59849;7984.6406911687955;8293.295069919124;8298.709545166132;8376.162383761819;8438.70464533763;9144.451332920045;12265.69335766613;12374.876251237372;12552.560660376843;12823.102382833113;11045.613403530839;11095.945885140898;11264.436778160894;11458.427078645867;11522.42387880586;10843.945780271048;11078.279911805706;11121.221514493907;11135.27620704684;11189.496472658913;11025.173112016791;11455.484503197209;11490.82763758561;11498.425078746197;11582.131340149353;7701;8179.386546008954;8324.750257492286;8422.115677853737;8586.356023298153;10401.323913945569;11101.38942358178;11111.222214444912;11361.4887330072;11375.43122843838 02:15:03 INFO - PROCESS | 22341 | |3;mootools.html;1322.9990635398185;1364.6588352911772;1454.607256040869;1546.2655238761583;1802.6034272460054;8721;9005.19896020796;9025.323100767444;9212.861807072899;9284.675036373728;8990.505522196276;9193.35646504745;9198.126178013077;9205.125513076264;9218.585163667634;1983.8214560689535;2158.913643454268;2240.7759224077627;2314.1784666443423;2354.376090336062;2353.976460235393;2361.6929799126087;2363.72817126031;2367.6566897799894;2367.7987371073477;2266.897989590464;2320.373499155227;2322.7909488146065;2323.1172154581236;2325.1280769711357;1928.594995051034;2244.472548950995;2322.5354929014097;2323.9767602323927;2342.648602709607;2205.470687035116;2223.855449395784;2226.643737002088;2227.4988127671145;2244.0799272298277;9216.815663686755;9260.629574817;9262.814743705088;9276.489793061379;9284.814303713887;5169.457206993249;5293.153095504739;5302.045631786277;5303.098473259516;5304.230886521472;3052.6489453712884;3140.607424071991;3199.600049993751;3203.3913556424204;3248;992.7815880506278;1035.1253191053547;1035.3632516002679;1057.8889216632297;1073.2111897755144;13024.088313818036;13055.347232638425;13092.345382730826;13116.147450415789;13144.474221031147;4460.375547423363;4516.887077823015;4608.124456353349;4611.953880461219;4692.366530518405;10871.565137394573;10876.401797901191;10883.83674244887;10886.237963342648;10888.183386246063;4651.09303685778;5194.714290713971;5254.527092561688;5256.684598924076;5263.763130659129;4566.725996440225;4700.294955756595;4702.6473014524045;4741.028089241697;4750.928736068961;3777.8299976501125;3868.903277418087;3902.453656488094;3912.061105334756;3955.5253369595835;1122.3490375582144;1126.915481338903;1130.2257953302014;1141.030124394275;1146.7362506623524;884.8230353929112;903.9005709371963;941.6657086734248;949.2643201518878;971.6162115964296;6250.281217659936;6349.2698339690605;6420.839479012969;6486.383888433866;6518.217813862367;453.8184726109583;459.0887089128078;464.05564675884415;464.9511801260887;469.2187507799476;4299.419578356944;4423.225935461282;4432.911341773147;4434.778261086933;4435.379046933432;10999;11399.943000284946;11428.200025998267;11447.656570302905;11503.712407189887;11253.943730281297;11320.094392448584;11321.150913681508;11331.886681133083;11349.886501135048;8106.716264930699;8416.957915210385;8418.116097809765;8591.183837535424;8611.741647750578;5545.778168873361;5991.490723288395;6352.491800656029;6360.141380913703;6504.544681872224;10191.184705223712;10479.214058945458;10543.57825686964;10556.102731267929;10644.520996555018;10697.893021069689;10719;10848.511816968414;10860.239783215098;10866.348019118563;7914.366850651819;7944.721934732488;7977.760667179994;8007.799805004922;8017.679292828221;8658.78353041179;8704.08607096271;8715.782105447415;8755.693550725695;8772.122787721431;7654.387648987956;7787.026621672291;7862;7880.527168369917;8067.83864322722;7787.260210280015;7803.336716379172;7888.881666775118;7999;8029;6896.27589103137;7146.499745017799;7148.857022859618;7273.563586184846;7340.412766978736;5293.682379057269;5349.572034237174;5428.050091233939;5443.210734443563;5560.443955604407;5326.840194794162;5379.892402152013;5478.04134276492;5488.341399032141;5542.584306176972 02:15:03 INFO - PROCESS | 22341 | |4;prototype.html;316.52837272464023;322.54682171548984;323.5486496337609;326.17315106205774;327.561068168654;5277.920831187535;5307.071262529056;5315;5316.946830531693;5359.517643412097;5188.16989281715;5233.764480598373;5249.790008399669;5257.158854583267;5258.342707161605;4016.6987475939277;4085.651734927467;4134;4147.1498342839795;4157.417961485395;4084.9183016339657;4086.3257562502154;4107.829268658433;4108.198901214264;4141;4037.1118353962083;4090.6931980101463;4109.589041095896;4112.588741125894;4131.338985762279;3865.7100717446306;3945.309570825123;4074.4720729726355;4093.833257521622;4122.021429713739;3591.2099338145827;3620.855165793365;3626.2384899171207;3638.872639457606;3641.817909104534;4994.77836795265;4998.175301075318;5006.424261209971;5068.341115654978;5086.821961231376;4484.686071974963;4601.470830854461;4655.441347038377;4667.253239481701;4696.412948381452;5423.7830486780485;5430.647007944511;5433.6196466247375;5441.673499590037;5441.891162176735;3910.963594647421;3914.628110329514;3949.6840252779707;3953.42675312081;3974.8807535773685;5545.34925516196;5592.86017849553;5626.774929002835;5631.943680563183;5667.886642267132;4030.5364883038824;4040.595940405936;4062.6749860011128;4067.654249388776;4078.530968938551;4143;4145.901336145924;4146.253674338648;4164.354525048622;4186.937195942063;4482.327650852399;4680.297955306732;4695.2252878275385;4763.190257656207;4765.8093676252565;5476.507114359647;5507.228987941691;5517.200005999188;5535.225068490415;5553.361363443175;1359.1709057474932;1368.637311112556;1387.9306034698225;1408.7816388459805;1414.504923276845;836.13958941355;880.3397451911067;883.1389395339493;887.8712586675025;887.992128933652;4726.692764970266;4731.597814185764;4746.5490778376;4766.213574760126;4799.904061880068;4988.979463317362;4995.12682743971;5025.467232494051;5096.261042148868;5157.355330583677;4759.4764575896625;4829.492903245179;4867.829625963145;4875.585575226146;5159.716215608102;2989.237744375214;2989.671136175019;2990;2998.3253767902047;3010.1270631516613;5875.823725288163;5878.412158784087;5907.4683278505145;5910.734016969247;5927.792527261611;5521.4478552144465;5678.290213723285;5701.800436984686;5729.28383952006;5780;5861.684634569236;5872.5301975842685;5881.794137205263;5903.881922361528;5923.614965027259;5401.648892821954;5639.533721232591;5695.772169113355;5708.54331653475;5769.307683078057;5668;5693;5693.658380497183;5708.315002199763;5725.654471199182;5959.165716799738;5977.910331344946;5978.432048955342;5979.252593425822;6004.609700369462;3844.269588778235;3988.262171498282;4003.5796241394232;4100.774457404752;4103.199876024147;5748;5763.135529670583;5770.163326317576;5787.160861675117;5799.739011744397;5603.7758489659955;5642.943570564406;5660.886782264414;5667.829965101054;5668.659880407189;5451.700156491431;5455.1271796512365;5476.479734425223;5489.972550137383;5530.806421775219;5393.191021346829;5393.462863084159;5432.945670543244;5437.755301011543;5446.537044351275;5206.739663016759;5316.468353164652;5484.588655850907;5571.66570005801;5574.216250799705;5368.436314186954;5381.973090134525;5395.649282796606;5422.186671999074;5454.4272851351625 02:15:03 INFO - PROCESS | 22341 | |5;yui.html;836.8326334733053;846.5640195299418;858.1418581418582;859.0409852714596;877.398981697537;14709.190994495311;15766.290516926738;15797.368105275804;15820.76268855968;15866.761998570017;14000;14195.503157389494;14226.71546569068;14589.489367872127;14659.853401465982;675.1257122026987;781.7967328494575;812.6586833529917;825.0553116681426;825.6325934958945;816.6651672814147;822.005373498068;822.0176888618104;822.1080128061061;822.2722890242148;868.3270465389311;871.7515508080166;873.7335112790596;873.7859224490009;873.9038705742363;703.359942452371;824.6000689665508;849.3290300662469;867.7743786615493;867.8177582707639;622.7633499270248;623.1525125828869;623.392192612204;623.5011990407655;623.7847942459889;13832.30838458073;13869.09850859691;13931.233782142079;13936.094153880067;13964.441422343094;13329.666758331023;13618.455261789517;13908.304584770822;14181.43274269028;14315.355808988621;12599.3070381129;12616.873831261753;12710.555130570478;12796.099627346564;12892.484300628057;4399.978000109979;4420.04968931678;4508.07584445188;4535.954640453586;4608.1705293047235;56302;57012.42987570154;57471.71264143694;57999.420005799824;58107.70946145285;10738.838917416246;10795.46022698862;10850.131989440826;10990.615328463466;11132.220744547965;20389.592208155755;20703.585928281653;20767.273145439838;20776.792232077787;20795;8407;8420.53687047206;8447.239748422671;8549.187827156411;8621.439606425562;4650.558196971282;4678.2280923647895;4793.5685788279225;4877.6585639004925;4903.754812259373;3375.274316022067;3459.135216195951;3465.7573969822374;3466;3473.14907847579;599.5353600959291;604.3593790581997;609.0954931926086;619.0806652121596;624.3600309682612;507.99746001269756;553.6511997441667;558.8602849287678;634.80321100459;636.6530241018656;9131.406458580172;9212.53937303132;9304;9311.580978855967;9315.39449935752;580.9506191973729;673.5823789250597;701.9122609673791;709.3828369318726;724.7753196509099;4278.144371125725;4334.591257841214;4384.210842048462;4458.974435879766;4520.118576877543;72489.27510724931;75220.24779752133;75835.62082189554;75926.24073759191;76453.61773191098;65313.346866531676;66177;66250.33749662538;66852.665736671;67778.3222167772;59611.999999999134;60529.39470605238;60901.39098608957;60903.39096609066;61186.388136118956;8672.826543469222;8895.555222238992;8899.15458031486;8927;9009.054049324988;38451.42322865215;38587.22825543529;38826.417603735405;38838.2232355357;38988.41517377185;48242.75878620584;51456;51873.14697691663;51952.48047519477;52688.47311526989;13099.476020959437;13137.211767293993;13174;13367.799483007957;13725.245111518563;14414.639634009234;14559.92720036393;14965.625859353604;15037.774433383289;15447.304871280594;13121.212727236396;13260.602181934557;13501.324933753469;13585.962105684226;13599.456021759415;13269.40287687037;13585.93207033998;13784.517541885985;13931.512397066053;14502.782458262924;13011.479540818262;13178.868211317764;13309.201447913156;13554.864451355756;13657.863421366057;10934.234603577674;11129.888701112885;11153.386563739072;11340.716482088013;11782.469788859693;10750.313376708724;11304.886951130713;11418.103039469692;11625.88374116248;11707.648770536898 02:15:03 INFO - PROCESS | 22341 | __end_tp_report 02:15:03 INFO - PROCESS | 22341 | __start_cc_report 02:15:03 INFO - PROCESS | 22341 | _x_x_mozilla_cycle_collect,874 02:15:03 INFO - PROCESS | 22341 | __end_cc_report 02:15:03 INFO - PROCESS | 22341 | __startTimestamp1464686103476__endTimestamp 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | ------- Summary: start ------- 02:15:03 INFO - PROCESS | 22341 | Number of tests: 6 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#0] dojo.html Cycles:165 Average:5438.75 Median:5630.66 stddev:640.19 (11.4%) stddev-sans-first:615.55 02:15:03 INFO - PROCESS | 22341 | Values: 3110.7 3151.4 3164.8 3201.4 3216.9 5297.2 5365.6 5499.2 5536.6 5576.7 5378.0 5423.2 5454.9 5467.0 5481.3 4857.0 4911.1 4936.8 4942.7 5106.4 4994.9 5022.4 5058.2 5079.3 5085.9 4761.7 4823.1 4851.8 4860.3 4884.7 4881.1 4889.7 4944.5 4961.6 5004.7 4829.3 4922.3 4940.3 4943.8 4956.1 5365.3 5435.8 5442.8 5518.2 5539.1 5959.5 5972.8 5991.7 5992.8 5996.9 5717.1 5815.2 5845.9 5933.6 5948.9 5516.1 5518.9 5522.0 5556.2 5568.3 6036.0 6048.3 6068.4 6068.5 6068.9 5507.2 5625.9 5733.1 5744.5 5791.0 5865.7 5868.5 5875.1 5879.6 5891.4 5780.9 5784.6 5840.4 5845.2 5849.4 5539.6 5745.2 5822.9 5869.3 5921.3 4399.8 4402.5 4407.8 4407.9 4443.7 3822.4 3902.8 3945.8 3962.9 3989.9 5496.1 5581.6 5596.1 5603.4 5631.6 5967.3 5968.5 5974.5 5979.3 6033.7 5411.3 5529.6 5609.2 5617.9 5630.7 4986.8 5045.9 5052.7 5055.6 5091.3 6141.0 6157.8 6160.7 6164.2 6166.9 5621.8 5816.8 5816.9 5948.3 5961.7 6023.9 6037.3 6040.6 6042.2 6050.4 5696.0 5729.6 5734.3 5753.8 5761.3 5699.7 5803.8 5816.5 5820.3 5856.6 5765.5 5789.9 5801.8 5805.4 5805.9 5694.8 5742.9 5760.7 5761.3 5776.7 5457.8 5558.5 5588.1 5619.6 5673.7 5797.7 5802.9 5854.6 5857.3 5857.6 5476.4 5644.6 5693.3 5695.8 5736.8 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#1] ext.html Cycles:180 Average:63016.64 Median:23757.61 stddev:125401.35 (527.8%) stddev-sans-first:125665.49 02:15:03 INFO - PROCESS | 22341 | Values: 571.4 625.1 625.5 643.6 647.0 32939.8 33501.3 45093.8 45998.5 46013.5 43609.8 46820.3 47041.3 47146.0 47171.5 8760.5 8965.3 8968.5 8974.0 8983.9 8742.3 8883.9 8886.5 8888.6 8895.6 8861.1 8881.9 8943.1 8943.9 8947.0 8891.8 8929.1 8937.0 8937.4 8941.6 8664.0 8673.2 8679.7 8690.8 8692.5 43030.1 43483.6 43515.3 43554.0 43585.3 3440.9 3603.1 3642.1 3729.4 3986.0 32272.8 32848.8 33161.8 34116.1 34218.3 4283.3 4295.2 4322.9 4349.8 4481.6 360199.0 361099.0 361281.0 361288.0 361865.0 62396.0 62428.4 62845.4 63181.0 63249.4 35991.1 36799.0 36858.1 38396.4 66091.0 16515.0 16538.4 16646.4 16713.0 16732.1 12467.4 12558.6 12560.9 12564.9 12579.7 20052.0 20170.4 20227.6 20248.5 20364.4 6959.3 7141.7 7246.3 7325.6 7412.8 959.8 1031.3 1053.4 1118.6 1190.7 32704.3 32919.8 33040.5 33350.5 33581.3 1128.9 1133.1 1184.7 1190.4 1210.1 17177.9 17380.0 17460.2 17481.7 17485.2 500534.0 502346.0 503350.0 504844.0 510205.0 59158.0 60465.0 60673.0 60700.4 60724.4 1270.6 1332.8 1347.6 1376.8 1392.3 32741.4 33676.5 33728.5 33771.0 34828.3 51835.7 55155.7 56853.0 56885.7 62628.4 530635.0 531942.0 535256.0 536791.0 538677.0 36219.0 37200.6 38270.0 46108.5 46693.3 46262.5 49710.3 50192.7 50739.0 51148.7 40759.8 42795.0 43260.6 43818.8 44601.0 42604.8 42755.0 43192.4 43245.8 43600.3 41265.6 41702.0 43042.1 43182.4 43190.6 34324.8 37279.0 37847.1 38021.8 38432.2 28076.9 28371.4 28385.7 28420.3 28441.6 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#2] jquery.html Cycles:180 Average:22261.94 Median:2626.61 stddev:49382.75 (1880.1%) stddev-sans-first:49493.97 02:15:03 INFO - PROCESS | 22341 | Values: 388.4 389.1 392.4 395.5 414.5 13856.4 16302.3 17839.7 19377.8 19399.1 17783.6 18035.2 18124.4 18405.4 18431.9 5602.9 5733.9 5771.2 5787.9 5797.2 3858.8 5661.4 5712.2 6116.8 6419.6 6432.6 6472.3 6490.5 6501.9 6509.0 6224.9 6458.0 6466.4 6472.0 6475.2 5450.5 5655.6 5656.0 5660.3 5686.8 21336.4 21890.1 22031.8 22095.7 22162.9 2301.7 2422.9 2511.4 2741.8 2754.6 9358.2 9719.4 9904.4 10032.0 14284.3 1807.4 1872.9 1908.2 1943.3 1955.5 57801.4 66061.3 66529.7 67694.7 72406.6 7835.2 8263.8 8326.3 8874.4 10138.7 11152.9 11245.0 11254.0 11269.7 11288.2 7302.9 7388.4 7431.7 7479.8 7604.0 7769.3 7777.0 7959.6 8158.5 8158.8 3504.5 3580.7 3638.9 3681.3 3750.0 1678.0 1757.8 1766.7 1807.4 1808.7 986.5 994.2 1024.1 1051.6 1061.3 18018.3 18801.8 18825.7 18927.6 19390.4 956.7 1000.6 1007.4 1013.4 1063.1 10322.8 10434.5 10619.0 10706.0 10792.4 233149.0 235212.0 236122.0 236251.0 444876.0 88094.0 91715.0 93152.8 93254.0 93680.1 1015.0 1030.1 1042.6 1051.8 1052.0 16667.9 16919.2 17141.1 17296.3 17596.4 40148.2 40540.4 40787.8 42641.6 42691.6 57168.0 58152.4 58955.1 59185.4 59849.0 7984.6 8293.3 8298.7 8376.2 8438.7 9144.5 12265.7 12374.9 12552.6 12823.1 11045.6 11095.9 11264.4 11458.4 11522.4 10843.9 11078.3 11121.2 11135.3 11189.5 11025.2 11455.5 11490.8 11498.4 11582.1 7701.0 8179.4 8324.8 8422.1 8586.4 10401.3 11101.4 11111.2 11361.5 11375.4 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#3] mootools.html Cycles:180 Average:5954.81 Median:2538.00 stddev:3527.64 (139.0%) stddev-sans-first:3520.36 02:15:03 INFO - PROCESS | 22341 | Values: 1323.0 1364.7 1454.6 1546.3 1802.6 8721.0 9005.2 9025.3 9212.9 9284.7 8990.5 9193.4 9198.1 9205.1 9218.6 1983.8 2158.9 2240.8 2314.2 2354.4 2354.0 2361.7 2363.7 2367.7 2367.8 2266.9 2320.4 2322.8 2323.1 2325.1 1928.6 2244.5 2322.5 2324.0 2342.6 2205.5 2223.9 2226.6 2227.5 2244.1 9216.8 9260.6 9262.8 9276.5 9284.8 5169.5 5293.2 5302.0 5303.1 5304.2 3052.6 3140.6 3199.6 3203.4 3248.0 992.8 1035.1 1035.4 1057.9 1073.2 13024.1 13055.3 13092.3 13116.1 13144.5 4460.4 4516.9 4608.1 4612.0 4692.4 10871.6 10876.4 10883.8 10886.2 10888.2 4651.1 5194.7 5254.5 5256.7 5263.8 4566.7 4700.3 4702.6 4741.0 4750.9 3777.8 3868.9 3902.5 3912.1 3955.5 1122.3 1126.9 1130.2 1141.0 1146.7 884.8 903.9 941.7 949.3 971.6 6250.3 6349.3 6420.8 6486.4 6518.2 453.8 459.1 464.1 465.0 469.2 4299.4 4423.2 4432.9 4434.8 4435.4 10999.0 11399.9 11428.2 11447.7 11503.7 11253.9 11320.1 11321.2 11331.9 11349.9 8106.7 8417.0 8418.1 8591.2 8611.7 5545.8 5991.5 6352.5 6360.1 6504.5 10191.2 10479.2 10543.6 10556.1 10644.5 10697.9 10719.0 10848.5 10860.2 10866.3 7914.4 7944.7 7977.8 8007.8 8017.7 8658.8 8704.1 8715.8 8755.7 8772.1 7654.4 7787.0 7862.0 7880.5 8067.8 7787.3 7803.3 7888.9 7999.0 8029.0 6896.3 7146.5 7148.9 7273.6 7340.4 5293.7 5349.6 5428.1 5443.2 5560.4 5326.8 5379.9 5478.0 5488.3 5542.6 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#4] prototype.html Cycles:180 Average:4605.59 Median:5197.45 stddev:1362.50 (26.2%) stddev-sans-first:1327.74 02:15:03 INFO - PROCESS | 22341 | Values: 316.5 322.5 323.5 326.2 327.6 5277.9 5307.1 5315.0 5316.9 5359.5 5188.2 5233.8 5249.8 5257.2 5258.3 4016.7 4085.7 4134.0 4147.1 4157.4 4084.9 4086.3 4107.8 4108.2 4141.0 4037.1 4090.7 4109.6 4112.6 4131.3 3865.7 3945.3 4074.5 4093.8 4122.0 3591.2 3620.9 3626.2 3638.9 3641.8 4994.8 4998.2 5006.4 5068.3 5086.8 4484.7 4601.5 4655.4 4667.3 4696.4 5423.8 5430.6 5433.6 5441.7 5441.9 3911.0 3914.6 3949.7 3953.4 3974.9 5545.3 5592.9 5626.8 5631.9 5667.9 4030.5 4040.6 4062.7 4067.7 4078.5 4143.0 4145.9 4146.3 4164.4 4186.9 4482.3 4680.3 4695.2 4763.2 4765.8 5476.5 5507.2 5517.2 5535.2 5553.4 1359.2 1368.6 1387.9 1408.8 1414.5 836.1 880.3 883.1 887.9 888.0 4726.7 4731.6 4746.5 4766.2 4799.9 4989.0 4995.1 5025.5 5096.3 5157.4 4759.5 4829.5 4867.8 4875.6 5159.7 2989.2 2989.7 2990.0 2998.3 3010.1 5875.8 5878.4 5907.5 5910.7 5927.8 5521.4 5678.3 5701.8 5729.3 5780.0 5861.7 5872.5 5881.8 5903.9 5923.6 5401.6 5639.5 5695.8 5708.5 5769.3 5668.0 5693.0 5693.7 5708.3 5725.7 5959.2 5977.9 5978.4 5979.3 6004.6 3844.3 3988.3 4003.6 4100.8 4103.2 5748.0 5763.1 5770.2 5787.2 5799.7 5603.8 5642.9 5660.9 5667.8 5668.7 5451.7 5455.1 5476.5 5490.0 5530.8 5393.2 5393.5 5432.9 5437.8 5446.5 5206.7 5316.5 5484.6 5571.7 5574.2 5368.4 5382.0 5395.6 5422.2 5454.4 02:15:03 INFO - PROCESS | 22341 | 02:15:03 INFO - PROCESS | 22341 | [#5] yui.html Cycles:180 Average:16484.34 Median:4664.39 stddev:20092.49 (430.8%) stddev-sans-first:20114.50 02:15:03 INFO - PROCESS | 22341 | Values: 836.8 846.6 858.1 859.0 877.4 14709.2 15766.3 15797.4 15820.8 15866.8 14000.0 14195.5 14226.7 14589.5 14659.9 675.1 781.8 812.7 825.1 825.6 816.7 822.0 822.0 822.1 822.3 868.3 871.8 873.7 873.8 873.9 703.4 824.6 849.3 867.8 867.8 622.8 623.2 623.4 623.5 623.8 13832.3 13869.1 13931.2 13936.1 13964.4 13329.7 13618.5 13908.3 14181.4 14315.4 12599.3 12616.9 12710.6 12796.1 12892.5 4400.0 4420.0 4508.1 4536.0 4608.2 56302.0 57012.4 57471.7 57999.4 58107.7 10738.8 10795.5 10850.1 10990.6 11132.2 20389.6 20703.6 20767.3 20776.8 20795.0 8407.0 8420.5 8447.2 8549.2 8621.4 4650.6 4678.2 4793.6 4877.7 4903.8 3375.3 3459.1 3465.8 3466.0 3473.1 599.5 604.4 609.1 619.1 624.4 508.0 553.7 558.9 634.8 636.7 9131.4 9212.5 9304.0 9311.6 9315.4 581.0 673.6 701.9 709.4 724.8 4278.1 4334.6 4384.2 4459.0 4520.1 72489.3 75220.2 75835.6 75926.2 76453.6 65313.3 66177.0 66250.3 66852.7 67778.3 59612.0 60529.4 60901.4 60903.4 61186.4 8672.8 8895.6 8899.2 8927.0 9009.1 38451.4 38587.2 38826.4 38838.2 38988.4 48242.8 51456.0 51873.1 51952.5 52688.5 13099.5 13137.2 13174.0 13367.8 13725.2 14414.6 14559.9 14965.6 15037.8 15447.3 13121.2 13260.6 13501.3 13586.0 13599.5 13269.4 13585.9 13784.5 13931.5 14502.8 13011.5 13178.9 13309.2 13554.9 13657.9 10934.2 11129.9 11153.4 11340.7 11782.5 10750.3 11304.9 11418.1 11625.9 11707.6 02:15:03 INFO - PROCESS | 22341 | -------- Summary: end -------- 02:15:03 INFO - PROCESS | 22341 | 02:15:04 INFO - TEST-INFO | 22341: exit 0 02:15:04 INFO - TEST-OK | dromaeo_css | took 1114298ms 02:15:04 INFO - TEST-START | kraken 02:15:04 INFO - operating with platform_type : linux_ 02:15:04 INFO - Initialising browser for kraken test... 02:15:04 INFO - TEST-INFO | started process 22533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGyfMo/profile http://localhost:50101/getInfo.html) 02:15:08 INFO - PROCESS | 22533 | __metrics Screen width/height:1600/1200 02:15:08 INFO - PROCESS | 22533 | colorDepth:24 02:15:08 INFO - PROCESS | 22533 | Browser inner width/height: 1024/697 02:15:08 INFO - PROCESS | 22533 | __metrics 02:15:09 ERROR - PROCESS | 22533 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:15:10 INFO - TEST-INFO | 22533: exit 0 02:15:10 INFO - Browser initialized. 02:15:10 INFO - Running cycle 1/1 for kraken test... 02:15:10 INFO - TEST-INFO | started process 22616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGyfMo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:22 INFO - PROCESS | 22616 | RSS: Main: 155979776 02:15:22 INFO - PROCESS | 22616 | 02:15:25 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50101/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:25 INFO - PROCESS | 22616 | RSS: Main: 213999616 02:15:25 INFO - PROCESS | 22616 | 02:15:28 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50101/tests/kraken/driver.html?testName=audio-dft) 02:15:29 INFO - PROCESS | 22616 | RSS: Main: 197865472 02:15:29 INFO - PROCESS | 22616 | 02:15:32 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50101/tests/kraken/driver.html?testName=audio-fft) 02:15:33 INFO - PROCESS | 22616 | RSS: Main: 268136448 02:15:33 INFO - PROCESS | 22616 | 02:15:35 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50101/tests/kraken/driver.html?testName=audio-oscillator) 02:15:35 INFO - PROCESS | 22616 | RSS: Main: 178913280 02:15:35 INFO - PROCESS | 22616 | 02:15:37 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:38 INFO - PROCESS | 22616 | RSS: Main: 183656448 02:15:38 INFO - PROCESS | 22616 | 02:15:41 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50101/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:42 INFO - PROCESS | 22616 | RSS: Main: 218021888 02:15:42 INFO - PROCESS | 22616 | 02:15:45 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50101/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:45 INFO - PROCESS | 22616 | RSS: Main: 220282880 02:15:45 INFO - PROCESS | 22616 | 02:15:48 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50101/tests/kraken/driver.html?testName=json-parse-financial) 02:15:49 INFO - PROCESS | 22616 | RSS: Main: 219869184 02:15:49 INFO - PROCESS | 22616 | 02:15:50 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:51 INFO - PROCESS | 22616 | RSS: Main: 208912384 02:15:51 INFO - PROCESS | 22616 | 02:15:53 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:53 INFO - PROCESS | 22616 | RSS: Main: 210792448 02:15:53 INFO - PROCESS | 22616 | 02:15:55 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:56 INFO - PROCESS | 22616 | RSS: Main: 217387008 02:15:56 INFO - PROCESS | 22616 | 02:15:59 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:59 INFO - PROCESS | 22616 | RSS: Main: 220770304 02:15:59 INFO - PROCESS | 22616 | 02:16:02 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:03 INFO - PROCESS | 22616 | RSS: Main: 222015488 02:16:03 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:50101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50101/tests/kraken/driver.html?testName=ai-astar) 02:16:04 INFO - PROCESS | 22616 | RSS: Main: 264552448 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | __start_tp_report 02:16:04 INFO - PROCESS | 22616 | _x_x_mozilla_page_load 02:16:04 INFO - PROCESS | 22616 | _x_x_mozilla_page_load_details 02:16:04 INFO - PROCESS | 22616 | |i|pagename|runs| 02:16:04 INFO - PROCESS | 22616 | |0;ai-astar;112;106;111;109;111;111;111;110;110;110 02:16:04 INFO - PROCESS | 22616 | |1;audio-beat-detection;152;129;128;179;125;133;153;124;194;131 02:16:04 INFO - PROCESS | 22616 | |2;audio-dft;162;161;163;161;161;160;161;162;160;162 02:16:04 INFO - PROCESS | 22616 | |3;audio-fft;74;73;75;118;74;75;74;74;107;74 02:16:04 INFO - PROCESS | 22616 | |4;audio-oscillator;83;84;110;82;83;84;121;83;83;135 02:16:04 INFO - PROCESS | 22616 | |5;imaging-gaussian-blur;116;117;117;117;116;117;116;116;116;117 02:16:04 INFO - PROCESS | 22616 | |6;imaging-darkroom;146;146;145;146;145;146;146;146;146;146 02:16:04 INFO - PROCESS | 22616 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 02:16:04 INFO - PROCESS | 22616 | |8;json-parse-financial;53;53;54;54;54;53;53;53;53;53 02:16:04 INFO - PROCESS | 22616 | |9;json-stringify-tinderbox;62;63;61;62;62;63;62;61;61;62 02:16:04 INFO - PROCESS | 22616 | |10;stanford-crypto-aes;85;82;80;78;86;81;81;81;119;87 02:16:04 INFO - PROCESS | 22616 | |11;stanford-crypto-ccm;120;122;125;123;119;121;116;127;123;124 02:16:04 INFO - PROCESS | 22616 | |12;stanford-crypto-pbkdf2;159;160;164;159;162;163;160;158;164;160 02:16:04 INFO - PROCESS | 22616 | |13;stanford-crypto-sha256-iterative;62;62;63;63;61;62;62;62;61;67 02:16:04 INFO - PROCESS | 22616 | __end_tp_report 02:16:04 INFO - PROCESS | 22616 | __start_cc_report 02:16:04 INFO - PROCESS | 22616 | _x_x_mozilla_cycle_collect,1645 02:16:04 INFO - PROCESS | 22616 | __end_cc_report 02:16:04 INFO - PROCESS | 22616 | __startTimestamp1464686164971__endTimestamp 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | ------- Summary: start ------- 02:16:04 INFO - PROCESS | 22616 | Number of tests: 14 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.66 (1.5%) stddev-sans-first:1.62 02:16:04 INFO - PROCESS | 22616 | Values: 112.0 106.0 111.0 109.0 111.0 111.0 111.0 110.0 110.0 110.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:142.50 stddev:24.48 (17.2%) stddev-sans-first:25.83 02:16:04 INFO - PROCESS | 22616 | Values: 152.0 129.0 128.0 179.0 125.0 133.0 153.0 124.0 194.0 131.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:16:04 INFO - PROCESS | 22616 | Values: 162.0 161.0 163.0 161.0 161.0 160.0 161.0 162.0 160.0 162.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:16.40 (22.2%) stddev-sans-first:17.15 02:16:04 INFO - PROCESS | 22616 | Values: 74.0 73.0 75.0 118.0 74.0 75.0 74.0 74.0 107.0 74.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.00 stddev:19.69 (23.7%) stddev-sans-first:20.41 02:16:04 INFO - PROCESS | 22616 | Values: 83.0 84.0 110.0 82.0 83.0 84.0 121.0 83.0 83.0 135.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:16:04 INFO - PROCESS | 22616 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:16:04 INFO - PROCESS | 22616 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:16:04 INFO - PROCESS | 22616 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 02:16:04 INFO - PROCESS | 22616 | Values: 53.0 53.0 54.0 54.0 54.0 53.0 53.0 53.0 53.0 53.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 02:16:04 INFO - PROCESS | 22616 | Values: 62.0 63.0 61.0 62.0 62.0 63.0 62.0 61.0 61.0 62.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:81.50 stddev:11.94 (14.6%) stddev-sans-first:12.65 02:16:04 INFO - PROCESS | 22616 | Values: 85.0 82.0 80.0 78.0 86.0 81.0 81.0 81.0 119.0 87.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.00 stddev:3.16 (2.6%) stddev-sans-first:3.27 02:16:04 INFO - PROCESS | 22616 | Values: 120.0 122.0 125.0 123.0 119.0 121.0 116.0 127.0 123.0 124.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.18 (1.4%) stddev-sans-first:2.20 02:16:04 INFO - PROCESS | 22616 | Values: 159.0 160.0 164.0 159.0 162.0 163.0 160.0 158.0 164.0 160.0 02:16:04 INFO - PROCESS | 22616 | 02:16:04 INFO - PROCESS | 22616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:1.72 (2.8%) stddev-sans-first:1.81 02:16:04 INFO - PROCESS | 22616 | Values: 62.0 62.0 63.0 63.0 61.0 62.0 62.0 62.0 61.0 67.0 02:16:04 INFO - PROCESS | 22616 | -------- Summary: end -------- 02:16:04 INFO - PROCESS | 22616 | 02:16:05 INFO - TEST-INFO | 22616: exit 0 02:16:05 INFO - TEST-OK | kraken | took 61774ms 02:16:05 INFO - SUITE-END | took 1176s 02:16:06 INFO - Completed test suite (00:19:36) 02:16:06 INFO - javascript benchmark 02:16:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.720035196833, 3151.432742106421, 3164.8259345735974, 3201.4397480440916, 3216.8713251469944, 5297.178937264721, 5365.570754339653, 5499.175123731437, 5536.640118392307, 5576.665400075994, 5377.973110134444, 5423.240746295512, 5454.863628409292, 5466.972665136679, 5481.342238931324, 4857.0, 4911.115999120157, 4936.777844996984, 4942.703437793726, 5106.361704786902, 4994.87512812179, 5022.372203474566, 5058.165402708567, 5079.339685840836, 5085.949140508585, 4761.738104404257, 4823.083614113307, 4851.830185943492, 4860.3195552622665, 4884.731339776311, 4881.1213981483315, 4889.706617602919, 4944.505549445063, 4961.5534601886, 5004.749762511896, 4829.299751536043, 4922.335484709554, 4940.28365886948, 4943.802247910079, 4956.083124621957, 5365.3293338332705, 5435.83692489226, 5442.782288708447, 5518.19986102017, 5539.058360078796, 5959.463648271676, 5972.761089556412, 5991.730372133265, 5992.820215393545, 5996.940030599681, 5717.085266357404, 5815.244018277639, 5845.853853653693, 5933.554983376264, 5948.940510594882, 5516.117421212587, 5518.889622207614, 5522.0, 5556.16657501374, 5568.303962004749, 6035.969820150871, 6048.274207095089, 6068.362821903725, 6068.514518838482, 6068.878622427526, 5507.228987941691, 5625.887482250332, 5733.111367738007, 5744.4829965303325, 5791.044477661138, 5865.706714664249, 5868.471837534642, 5875.059990401515, 5879.647221166658, 5891.351951285355, 5780.855478613068, 5784.623999440023, 5840.3575606683235, 5845.210896528999, 5849.3858144894175, 5539.556835453154, 5745.195672605839, 5822.883542329129, 5869.295684517885, 5921.348651648315, 4399.780010999437, 4402.537733537996, 4407.845725399596, 4407.933880991788, 4443.6889417741095, 3822.3502004659276, 3902.804859757001, 3945.822437990297, 3962.8612998544913, 3989.880303590897, 5496.148097044965, 5581.581381396411, 5596.104623260258, 5603.411641777555, 5631.577631677641, 5967.313758917693, 5968.46283834457, 5974.492168165754, 5979.282486101695, 6033.668148251888, 5411.269478620336, 5529.640573362719, 5609.158626206102, 5617.943820561742, 5630.662160270397, 4986.750662466862, 5045.949540504548, 5052.72210028452, 5055.620828437882, 5091.3381260436645, 6141.0, 6157.815265542041, 6160.722767475474, 6164.229471316085, 6166.9383306167265, 5621.831345059655, 5816.76732930678, 5816.941830581809, 5948.315943666534, 5961.672108033927, 6023.909641355471, 6037.335893051673, 6040.607360521552, 6042.1843051187525, 6050.42520960508, 5696.0, 5729.570282228766, 5734.311882574118, 5753.798617048383, 5761.251037365116, 5699.743511542073, 5803.82588522345, 5816.5055970243, 5820.330661973927, 5856.619319744203, 5765.481106700249, 5789.91315130265, 5801.76792928295, 5805.361410244954, 5805.883882322245, 5694.800681976111, 5742.885142297047, 5760.711964401679, 5761.251037365116, 5776.7400466979925, 5457.781688732406, 5558.499735023867, 5588.050031494575, 5619.606627536034, 5673.716314184192, 5797.739101740516, 5802.912956305574, 5854.590178687451, 5857.26784151981, 5857.58996870215, 5476.424975377688, 5644.604877658525, 5693.3168019837885, 5695.772169113189, 5736.770529178953], "value": 5394.270064273002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4314257313971, 625.0780099353454, 625.5339771869958, 643.5527308520581, 646.9644169570674, 32939.83530082349, 33501.32997340052, 45093.774531127296, 45998.54001459984, 46013.53986460134, 43609.78195109028, 46820.297695534595, 47041.29438058432, 47146.0, 47171.52828471714, 8760.51817150055, 8965.32760042996, 8968.46189228645, 8974.0, 8983.865242021375, 8742.344324175681, 8883.866741998876, 8886.511241881693, 8888.555572221396, 8895.644174233055, 8861.11388861112, 8881.911180888206, 8943.105689431037, 8943.865842012376, 8947.0, 8891.822163556724, 8929.06244844295, 8937.0, 8937.419067760575, 8941.552922353889, 8663.956680216621, 8673.176048275403, 8679.652813887436, 8690.782730431727, 8692.478451292942, 43030.139397212195, 43483.56516434827, 43515.34726979098, 43554.0, 43585.34621980673, 3440.8795692150657, 3603.1172362771026, 3642.1258897864586, 3729.4219395993664, 3986.0, 32272.838635806904, 32848.83575582131, 33161.83419082913, 34116.147096322544, 34218.31563368744, 4283.336082907154, 4295.226859165349, 4322.870313890557, 4349.782510874444, 4481.64146868253, 360199.0, 361099.0, 361281.0, 361288.0, 361865.0, 62396.0, 62428.375716243165, 62845.371546283954, 63181.0, 63249.36750632435, 35991.10022249465, 36799.03213066202, 36858.078548036516, 38396.42405363922, 66091.0, 16515.0, 16538.421155259508, 16646.417375391804, 16713.0, 16732.079735614658, 12467.438965246585, 12558.560450384193, 12560.874391255971, 12564.937175314066, 12579.685507862378, 20052.0, 20170.394888153085, 20227.595448090957, 20248.493787655425, 20364.389068327975, 6959.269276725972, 7141.714811186912, 7246.347828695442, 7325.6337183141695, 7412.813949768011, 959.7840485890758, 1031.2832581356035, 1053.373242920461, 1118.608487029533, 1190.7142285851507, 32704.34591308208, 32919.83540082284, 33040.50439243413, 33350.49974250388, 33581.32837343239, 1128.9322640641587, 1133.1218305812897, 1184.7215904262664, 1190.357207108152, 1210.074293165729, 17177.914110429367, 17380.0, 17460.214290356966, 17481.650366992588, 17485.213165407586, 500534.0, 502346.0, 503350.0, 504844.0, 510205.0, 59158.0, 60465.0, 60673.0, 60700.39299607036, 60724.39275607187, 1270.6124631987147, 1332.80007998799, 1347.636138242669, 1376.827896512936, 1392.3455975691409, 32741.398446171377, 33676.49485257772, 33728.49407258844, 33771.0, 34828.30343393169, 51835.74082129565, 55155.72422138024, 56853.0, 56885.715571421875, 62628.373716264075, 530635.0, 531942.0, 535256.0, 536791.0, 538677.0, 36219.0, 37200.62799371972, 38270.0, 46108.53891461177, 46693.29960050534, 46262.53737462583, 49710.25434618411, 50192.74903625459, 50739.0, 51148.74425627848, 40759.796201018806, 42795.0, 43260.567394326914, 43818.780906095264, 44601.0, 42604.78697606492, 42755.0, 43192.35211471893, 43245.78377108094, 43600.34599481074, 41265.58734412617, 41702.0, 43042.13915721731, 43182.352264715424, 43190.56809431865, 34324.828375857964, 37279.0, 37847.10764461821, 38021.80989095037, 38432.231355372176, 28076.85961570179, 28371.43257134887, 28385.716142838308, 28420.289492762848, 28441.573376398956], "value": 20668.25682305227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.4270700716444, 389.1205874723125, 392.3722044728437, 395.5451231084253, 414.54607205110415, 13856.38656174998, 16302.347906083773, 17839.732404013936, 19377.806221937775, 19399.12703928323, 17783.64432711345, 18035.188416521254, 18124.36564720235, 18405.355812546564, 18431.90784046081, 5602.85992850179, 5733.942660573403, 5771.192033115367, 5787.913181302284, 5797.188393624896, 3858.84564617415, 5661.405552416999, 5712.22884910538, 6116.7553297868035, 6419.64691941943, 6432.646204458753, 6472.288048314682, 6490.4807615390655, 6501.862174119534, 6509.0, 6224.906626400608, 6458.031295305695, 6466.418022377985, 6472.0, 6475.190601174853, 5450.482204190595, 5655.575831812631, 5656.038473459522, 5660.3490598581275, 5686.772529098831, 21336.359909202747, 21890.12439502418, 22031.779682203134, 22095.668564971376, 22162.88918555397, 2301.7122859642545, 2422.8909699063584, 2511.4474815540552, 2741.7669498092687, 2754.560687347409, 9358.15776580111, 9719.36824106438, 9904.405735655884, 10031.996800319983, 14284.285785710777, 1807.4455967867623, 1872.87826291292, 1908.1794828223858, 1943.3399602385687, 1955.511122219445, 57801.42198578044, 66061.33938660599, 66529.66735166294, 67694.66152669255, 72406.63796681036, 7835.216478352119, 8263.834723305501, 8326.333893288522, 8874.423162494417, 10138.695839124837, 11152.888471115184, 11245.0, 11254.0, 11269.71825704364, 11288.153388495732, 7302.853942921218, 7388.408927285805, 7431.665575049135, 7479.813004674927, 7604.0, 7769.339606133542, 7776.950111734956, 7959.641816118288, 8158.469699469515, 8158.796030099295, 3504.491848681927, 3580.7135429165605, 3638.890833274953, 3681.3005528949416, 3750.0, 1677.991610041942, 1757.77148970633, 1766.7084930986243, 1807.3854889337688, 1808.7171783213425, 986.4820968991194, 994.2294721590825, 1024.109025148126, 1051.5793682526898, 1061.2571200159919, 18018.278834587, 18801.80369337216, 18825.717614235797, 18927.621447571248, 19390.4182874514, 956.732329663199, 1000.573608998191, 1007.3502590829021, 1013.381837079381, 1063.1335461598926, 10322.812876519147, 10434.530446129942, 10619.0, 10705.982931621484, 10792.352458852494, 233149.0, 235212.0, 236122.0, 236251.0, 444876.0, 88094.0, 91715.0, 93152.82116482005, 93254.0, 93680.0972906165, 1015.0, 1030.07808011829, 1042.593388578455, 1051.81593221186, 1051.9789604207872, 16667.91666041662, 16919.238634261736, 17141.14294285256, 17296.308147674456, 17596.38412655551, 40148.19703605853, 40540.39189412102, 40787.796061020694, 42641.57358426376, 42691.57308427, 57168.0, 58152.4184758147, 58955.115673264074, 59185.40814591799, 59849.0, 7984.6406911687955, 8293.295069919124, 8298.709545166132, 8376.162383761819, 8438.70464533763, 9144.451332920045, 12265.69335766613, 12374.876251237372, 12552.560660376843, 12823.102382833113, 11045.613403530839, 11095.945885140898, 11264.436778160894, 11458.427078645867, 11522.42387880586, 10843.945780271048, 11078.279911805706, 11121.221514493907, 11135.27620704684, 11189.496472658913, 11025.173112016791, 11455.484503197209, 11490.82763758561, 11498.425078746197, 11582.131340149353, 7701.0, 8179.386546008954, 8324.750257492286, 8422.115677853737, 8586.356023298153, 10401.323913945569, 11101.38942358178, 11111.222214444912, 11361.4887330072, 11375.43122843838], "value": 8726.811994428792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.9990635398185, 1364.6588352911772, 1454.607256040869, 1546.2655238761583, 1802.6034272460054, 8721.0, 9005.19896020796, 9025.323100767444, 9212.861807072899, 9284.675036373728, 8990.505522196276, 9193.35646504745, 9198.126178013077, 9205.125513076264, 9218.585163667634, 1983.8214560689535, 2158.913643454268, 2240.7759224077627, 2314.1784666443423, 2354.376090336062, 2353.976460235393, 2361.6929799126087, 2363.72817126031, 2367.6566897799894, 2367.7987371073477, 2266.897989590464, 2320.373499155227, 2322.7909488146065, 2323.1172154581236, 2325.1280769711357, 1928.594995051034, 2244.472548950995, 2322.5354929014097, 2323.9767602323927, 2342.648602709607, 2205.470687035116, 2223.855449395784, 2226.643737002088, 2227.4988127671145, 2244.0799272298277, 9216.815663686755, 9260.629574817, 9262.814743705088, 9276.489793061379, 9284.814303713887, 5169.457206993249, 5293.153095504739, 5302.045631786277, 5303.098473259516, 5304.230886521472, 3052.6489453712884, 3140.607424071991, 3199.600049993751, 3203.3913556424204, 3248.0, 992.7815880506278, 1035.1253191053547, 1035.3632516002679, 1057.8889216632297, 1073.2111897755144, 13024.088313818036, 13055.347232638425, 13092.345382730826, 13116.147450415789, 13144.474221031147, 4460.375547423363, 4516.887077823015, 4608.124456353349, 4611.953880461219, 4692.366530518405, 10871.565137394573, 10876.401797901191, 10883.83674244887, 10886.237963342648, 10888.183386246063, 4651.09303685778, 5194.714290713971, 5254.527092561688, 5256.684598924076, 5263.763130659129, 4566.725996440225, 4700.294955756595, 4702.6473014524045, 4741.028089241697, 4750.928736068961, 3777.8299976501125, 3868.903277418087, 3902.453656488094, 3912.061105334756, 3955.5253369595835, 1122.3490375582144, 1126.915481338903, 1130.2257953302014, 1141.030124394275, 1146.7362506623524, 884.8230353929112, 903.9005709371963, 941.6657086734248, 949.2643201518878, 971.6162115964296, 6250.281217659936, 6349.2698339690605, 6420.839479012969, 6486.383888433866, 6518.217813862367, 453.8184726109583, 459.0887089128078, 464.05564675884415, 464.9511801260887, 469.2187507799476, 4299.419578356944, 4423.225935461282, 4432.911341773147, 4434.778261086933, 4435.379046933432, 10999.0, 11399.943000284946, 11428.200025998267, 11447.656570302905, 11503.712407189887, 11253.943730281297, 11320.094392448584, 11321.150913681508, 11331.886681133083, 11349.886501135048, 8106.716264930699, 8416.957915210385, 8418.116097809765, 8591.183837535424, 8611.741647750578, 5545.778168873361, 5991.490723288395, 6352.491800656029, 6360.141380913703, 6504.544681872224, 10191.184705223712, 10479.214058945458, 10543.57825686964, 10556.102731267929, 10644.520996555018, 10697.893021069689, 10719.0, 10848.511816968414, 10860.239783215098, 10866.348019118563, 7914.366850651819, 7944.721934732488, 7977.760667179994, 8007.799805004922, 8017.679292828221, 8658.78353041179, 8704.08607096271, 8715.782105447415, 8755.693550725695, 8772.122787721431, 7654.387648987956, 7787.026621672291, 7862.0, 7880.527168369917, 8067.83864322722, 7787.260210280015, 7803.336716379172, 7888.881666775118, 7999.0, 8029.0, 6896.27589103137, 7146.499745017799, 7148.857022859618, 7273.563586184846, 7340.412766978736, 5293.682379057269, 5349.572034237174, 5428.050091233939, 5443.210734443563, 5560.443955604407, 5326.840194794162, 5379.892402152013, 5478.04134276492, 5488.341399032141, 5542.584306176972], "value": 4594.21628885948, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.52837272464023, 322.54682171548984, 323.5486496337609, 326.17315106205774, 327.561068168654, 5277.920831187535, 5307.071262529056, 5315.0, 5316.946830531693, 5359.517643412097, 5188.16989281715, 5233.764480598373, 5249.790008399669, 5257.158854583267, 5258.342707161605, 4016.6987475939277, 4085.651734927467, 4134.0, 4147.1498342839795, 4157.417961485395, 4084.9183016339657, 4086.3257562502154, 4107.829268658433, 4108.198901214264, 4141.0, 4037.1118353962083, 4090.6931980101463, 4109.589041095896, 4112.588741125894, 4131.338985762279, 3865.7100717446306, 3945.309570825123, 4074.4720729726355, 4093.833257521622, 4122.021429713739, 3591.2099338145827, 3620.855165793365, 3626.2384899171207, 3638.872639457606, 3641.817909104534, 4994.77836795265, 4998.175301075318, 5006.424261209971, 5068.341115654978, 5086.821961231376, 4484.686071974963, 4601.470830854461, 4655.441347038377, 4667.253239481701, 4696.412948381452, 5423.7830486780485, 5430.647007944511, 5433.6196466247375, 5441.673499590037, 5441.891162176735, 3910.963594647421, 3914.628110329514, 3949.6840252779707, 3953.42675312081, 3974.8807535773685, 5545.34925516196, 5592.86017849553, 5626.774929002835, 5631.943680563183, 5667.886642267132, 4030.5364883038824, 4040.595940405936, 4062.6749860011128, 4067.654249388776, 4078.530968938551, 4143.0, 4145.901336145924, 4146.253674338648, 4164.354525048622, 4186.937195942063, 4482.327650852399, 4680.297955306732, 4695.2252878275385, 4763.190257656207, 4765.8093676252565, 5476.507114359647, 5507.228987941691, 5517.200005999188, 5535.225068490415, 5553.361363443175, 1359.1709057474932, 1368.637311112556, 1387.9306034698225, 1408.7816388459805, 1414.504923276845, 836.13958941355, 880.3397451911067, 883.1389395339493, 887.8712586675025, 887.992128933652, 4726.692764970266, 4731.597814185764, 4746.5490778376, 4766.213574760126, 4799.904061880068, 4988.979463317362, 4995.12682743971, 5025.467232494051, 5096.261042148868, 5157.355330583677, 4759.4764575896625, 4829.492903245179, 4867.829625963145, 4875.585575226146, 5159.716215608102, 2989.237744375214, 2989.671136175019, 2990.0, 2998.3253767902047, 3010.1270631516613, 5875.823725288163, 5878.412158784087, 5907.4683278505145, 5910.734016969247, 5927.792527261611, 5521.4478552144465, 5678.290213723285, 5701.800436984686, 5729.28383952006, 5780.0, 5861.684634569236, 5872.5301975842685, 5881.794137205263, 5903.881922361528, 5923.614965027259, 5401.648892821954, 5639.533721232591, 5695.772169113355, 5708.54331653475, 5769.307683078057, 5668.0, 5693.0, 5693.658380497183, 5708.315002199763, 5725.654471199182, 5959.165716799738, 5977.910331344946, 5978.432048955342, 5979.252593425822, 6004.609700369462, 3844.269588778235, 3988.262171498282, 4003.5796241394232, 4100.774457404752, 4103.199876024147, 5748.0, 5763.135529670583, 5770.163326317576, 5787.160861675117, 5799.739011744397, 5603.7758489659955, 5642.943570564406, 5660.886782264414, 5667.829965101054, 5668.659880407189, 5451.700156491431, 5455.1271796512365, 5476.479734425223, 5489.972550137383, 5530.806421775219, 5393.191021346829, 5393.462863084159, 5432.945670543244, 5437.755301011543, 5446.537044351275, 5206.739663016759, 5316.468353164652, 5484.588655850907, 5571.66570005801, 5574.216250799705, 5368.436314186954, 5381.973090134525, 5395.649282796606, 5422.186671999074, 5454.4272851351625], "value": 4166.312878534107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.8326334733053, 846.5640195299418, 858.1418581418582, 859.0409852714596, 877.398981697537, 14709.190994495311, 15766.290516926738, 15797.368105275804, 15820.76268855968, 15866.761998570017, 14000.0, 14195.503157389494, 14226.71546569068, 14589.489367872127, 14659.853401465982, 675.1257122026987, 781.7967328494575, 812.6586833529917, 825.0553116681426, 825.6325934958945, 816.6651672814147, 822.005373498068, 822.0176888618104, 822.1080128061061, 822.2722890242148, 868.3270465389311, 871.7515508080166, 873.7335112790596, 873.7859224490009, 873.9038705742363, 703.359942452371, 824.6000689665508, 849.3290300662469, 867.7743786615493, 867.8177582707639, 622.7633499270248, 623.1525125828869, 623.392192612204, 623.5011990407655, 623.7847942459889, 13832.30838458073, 13869.09850859691, 13931.233782142079, 13936.094153880067, 13964.441422343094, 13329.666758331023, 13618.455261789517, 13908.304584770822, 14181.43274269028, 14315.355808988621, 12599.3070381129, 12616.873831261753, 12710.555130570478, 12796.099627346564, 12892.484300628057, 4399.978000109979, 4420.04968931678, 4508.07584445188, 4535.954640453586, 4608.1705293047235, 56302.0, 57012.42987570154, 57471.71264143694, 57999.420005799824, 58107.70946145285, 10738.838917416246, 10795.46022698862, 10850.131989440826, 10990.615328463466, 11132.220744547965, 20389.592208155755, 20703.585928281653, 20767.273145439838, 20776.792232077787, 20795.0, 8407.0, 8420.53687047206, 8447.239748422671, 8549.187827156411, 8621.439606425562, 4650.558196971282, 4678.2280923647895, 4793.5685788279225, 4877.6585639004925, 4903.754812259373, 3375.274316022067, 3459.135216195951, 3465.7573969822374, 3466.0, 3473.14907847579, 599.5353600959291, 604.3593790581997, 609.0954931926086, 619.0806652121596, 624.3600309682612, 507.99746001269756, 553.6511997441667, 558.8602849287678, 634.80321100459, 636.6530241018656, 9131.406458580172, 9212.53937303132, 9304.0, 9311.580978855967, 9315.39449935752, 580.9506191973729, 673.5823789250597, 701.9122609673791, 709.3828369318726, 724.7753196509099, 4278.144371125725, 4334.591257841214, 4384.210842048462, 4458.974435879766, 4520.118576877543, 72489.27510724931, 75220.24779752133, 75835.62082189554, 75926.24073759191, 76453.61773191098, 65313.346866531676, 66177.0, 66250.33749662538, 66852.665736671, 67778.3222167772, 59611.999999999134, 60529.39470605238, 60901.39098608957, 60903.39096609066, 61186.388136118956, 8672.826543469222, 8895.555222238992, 8899.15458031486, 8927.0, 9009.054049324988, 38451.42322865215, 38587.22825543529, 38826.417603735405, 38838.2232355357, 38988.41517377185, 48242.75878620584, 51456.0, 51873.14697691663, 51952.48047519477, 52688.47311526989, 13099.476020959437, 13137.211767293993, 13174.0, 13367.799483007957, 13725.245111518563, 14414.639634009234, 14559.92720036393, 14965.625859353604, 15037.774433383289, 15447.304871280594, 13121.212727236396, 13260.602181934557, 13501.324933753469, 13585.962105684226, 13599.456021759415, 13269.40287687037, 13585.93207033998, 13784.517541885985, 13931.512397066053, 14502.782458262924, 13011.479540818262, 13178.868211317764, 13309.201447913156, 13554.864451355756, 13657.863421366057, 10934.234603577674, 11129.888701112885, 11153.386563739072, 11340.716482088013, 11782.469788859693, 10750.313376708724, 11304.886951130713, 11418.103039469692, 11625.88374116248, 11707.648770536898], "value": 7061.053854947002, "unit": "score"}], "name": "dromaeo_css", "value": 7131.187532824391, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 128.0, 179.0, 125.0, 133.0, 153.0, 124.0, 194.0, 131.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 118.0, 74.0, 75.0, 74.0, 74.0, 107.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 82.0, 83.0, 84.0, 121.0, 83.0, 83.0, 135.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 80.0, 78.0, 86.0, 81.0, 81.0, 81.0, 119.0, 87.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 125.0, 123.0, 119.0, 121.0, 116.0, 127.0, 123.0, 124.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 164.0, 159.0, 162.0, 163.0, 160.0, 158.0, 164.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 61.0, 62.0, 62.0, 62.0, 61.0, 67.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1496.5000000000002, "alertThreshold": 2.0}]} 02:16:06 INFO - Return code: 0 02:16:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:16:06 ERROR - # TBPL SUCCESS # 02:16:06 INFO - Running post-action listener: _resource_record_post_action 02:16:06 INFO - ##### 02:16:06 INFO - ##### Finished run-tests step (success) 02:16:06 INFO - ##### 02:16:06 INFO - Running post-run listener: _resource_record_post_run 02:16:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549122048; Read time: 4; Write time: 518636 02:16:06 INFO - TinderboxPrint: CPU usage
13.2% 02:16:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 02:16:06 INFO - TinderboxPrint: I/O write bytes / time
549,122,048 / 518,636 02:16:06 INFO - TinderboxPrint: CPU idle
8,274.3 (86.8%) 02:16:06 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 02:16:06 INFO - TinderboxPrint: Swap in / out
0 / 0 02:16:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257511424; Read time: 0; Write time: 239976 02:16:06 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291442688; Read time: 4; Write time: 278644 02:16:06 INFO - Running post-run listener: _upload_blobber_files 02:16:06 INFO - Blob upload gear active. 02:16:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:16:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:16:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:11 INFO - (blobuploader) - INFO - Done attempting. 02:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:12 INFO - (blobuploader) - INFO - Done attempting. 02:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:13 INFO - (blobuploader) - INFO - Done attempting. 02:16:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:16:13 INFO - Return code: 0 02:16:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:16:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:16:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a5d8a44ec0aa2cd64cab04edaabf2b4eb6fe9daaf4891dd2697d2a09ab2d049acf77bf69a88e9d4075fde5480de069b1c965aabdf0cb616387bd9312a7302c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba9e1414e31bc0ff7e2d862433dbba2a3d700c8602a15e27e56cbf21bd8095fec2778067bd9ee7f0d22365222277c04efa2196b7e6a1c9a1831fb9d12fa08ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc074d01e6af81bcc7910eaca20bceb4d819f0b0da25a1e13725db0fcb95d6fe123c2775f8473a9bb73f24c040720dd3f2f79894e819ea2b5a07b3b9e312ad8d"} 02:16:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:16:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:16:13 INFO - Contents: 02:16:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a5d8a44ec0aa2cd64cab04edaabf2b4eb6fe9daaf4891dd2697d2a09ab2d049acf77bf69a88e9d4075fde5480de069b1c965aabdf0cb616387bd9312a7302c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba9e1414e31bc0ff7e2d862433dbba2a3d700c8602a15e27e56cbf21bd8095fec2778067bd9ee7f0d22365222277c04efa2196b7e6a1c9a1831fb9d12fa08ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc074d01e6af81bcc7910eaca20bceb4d819f0b0da25a1e13725db0fcb95d6fe123c2775f8473a9bb73f24c040720dd3f2f79894e819ea2b5a07b3b9e312ad8d"} 02:16:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:16:13 INFO - Copying logs to upload dir... 02:16:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:16:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.079514 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-31 02:16:12.909864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:16:12.913994) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a5d8a44ec0aa2cd64cab04edaabf2b4eb6fe9daaf4891dd2697d2a09ab2d049acf77bf69a88e9d4075fde5480de069b1c965aabdf0cb616387bd9312a7302c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba9e1414e31bc0ff7e2d862433dbba2a3d700c8602a15e27e56cbf21bd8095fec2778067bd9ee7f0d22365222277c04efa2196b7e6a1c9a1831fb9d12fa08ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc074d01e6af81bcc7910eaca20bceb4d819f0b0da25a1e13725db0fcb95d6fe123c2775f8473a9bb73f24c040720dd3f2f79894e819ea2b5a07b3b9e312ad8d"} build_url:https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/d--_e9siSZm3WTow699FSQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a5d8a44ec0aa2cd64cab04edaabf2b4eb6fe9daaf4891dd2697d2a09ab2d049acf77bf69a88e9d4075fde5480de069b1c965aabdf0cb616387bd9312a7302c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba9e1414e31bc0ff7e2d862433dbba2a3d700c8602a15e27e56cbf21bd8095fec2778067bd9ee7f0d22365222277c04efa2196b7e6a1c9a1831fb9d12fa08ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc074d01e6af81bcc7910eaca20bceb4d819f0b0da25a1e13725db0fcb95d6fe123c2775f8473a9bb73f24c040720dd3f2f79894e819ea2b5a07b3b9e312ad8d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:16:12.939953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:16:12.940294) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464683324.571401-917209701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:16:13.023557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:16:13.023879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:16:13.024188) ========= ========= Total master_lag: 0.17 =========