builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1464404972.79 results: success (0) buildid: 20160527173012 builduid: d4d996ce4978400db38ff8dde94cf571 revision: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.795032) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.795791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.796163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.820989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.821309) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 20:09: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% 19.6M=0.001s 2016-05-27 20:09:33 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.922687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.923022) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:32.980095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 20:09:32.980469) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 --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 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 --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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 20:09:33,767 truncating revision to first 12 chars 2016-05-27 20:09:33,768 Setting DEBUG logging. 2016-05-27 20:09:33,768 attempt 1/10 2016-05-27 20:09:33,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bd815acf6d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 20:09:34,591 unpacking tar archive at: fx-team-1bd815acf6d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 20:09:34.177506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:34.177835) ========= script_repo_revision: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:34.178295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:34.178627) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 20:09:34.187683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 20:09:34.188000) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:35 INFO - MultiFileLogger online at 20160527 20:09:35 in /builds/slave/test 20:09:35 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 20:09:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:35 INFO - {'append_to_log': False, 20:09:35 INFO - 'base_work_dir': '/builds/slave/test', 20:09:35 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:35 INFO - 'branch': 'Fx-Team', 20:09:35 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:35 INFO - 'config_files': ('talos/linux_config.py',), 20:09:35 INFO - 'default_actions': ('clobber', 20:09:35 INFO - 'read-buildbot-config', 20:09:35 INFO - 'download-and-extract', 20:09:35 INFO - 'populate-webroot', 20:09:35 INFO - 'create-virtualenv', 20:09:35 INFO - 'install', 20:09:35 INFO - 'run-tests'), 20:09:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:35 INFO - 'download_minidump_stackwalk': True, 20:09:35 INFO - 'download_symbols': 'ondemand', 20:09:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:35 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:35 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:35 INFO - 'installer_path': 'installer.exe', 20:09:35 INFO - 'log_level': 'info', 20:09:35 INFO - 'log_name': 'talos', 20:09:35 INFO - 'log_to_console': True, 20:09:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:35 INFO - 'opt_config_files': (), 20:09:35 INFO - 'pip_index': False, 20:09:35 INFO - 'sps_profile': False, 20:09:35 INFO - 'sps_profile_interval': 0, 20:09:35 INFO - 'suite': 'dromaeojs', 20:09:35 INFO - 'system_bits': '32', 20:09:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:35 INFO - 'title': 'talos-linux64-ix-005', 20:09:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:35 INFO - 'use_talos_json': True, 20:09:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:35 INFO - 'work_dir': 'build'} 20:09:35 INFO - ##### 20:09:35 INFO - ##### Running clobber step. 20:09:35 INFO - ##### 20:09:35 INFO - Running pre-action listener: _resource_record_pre_action 20:09:35 INFO - Running main action method: clobber 20:09:35 INFO - rmtree: /builds/slave/test/build 20:09:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:36 INFO - Running post-action listener: _resource_record_post_action 20:09:36 INFO - ##### 20:09:36 INFO - ##### Finished clobber step (success) 20:09:36 INFO - ##### 20:09:36 INFO - ##### 20:09:36 INFO - ##### Running read-buildbot-config step. 20:09:36 INFO - ##### 20:09:36 INFO - Running pre-action listener: _resource_record_pre_action 20:09:36 INFO - Running main action method: read_buildbot_config 20:09:36 INFO - Using buildbot properties: 20:09:36 INFO - { 20:09:36 INFO - "project": "", 20:09:36 INFO - "product": "firefox", 20:09:36 INFO - "script_repo_revision": "production", 20:09:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:09:36 INFO - "repository": "", 20:09:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:09:36 INFO - "buildid": "20160527173012", 20:09:36 INFO - "pgo_build": "True", 20:09:36 INFO - "basedir": "/builds/slave/test", 20:09:36 INFO - "buildnumber": 729, 20:09:36 INFO - "slavename": "talos-linux64-ix-005", 20:09:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:09:36 INFO - "platform": "ubuntu64_hw", 20:09:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:36 INFO - "branch": "fx-team", 20:09:36 INFO - "repo_path": "integration/fx-team", 20:09:36 INFO - "revision": "1bd815acf6d3d51ded73a0ffbe05bd8a2c515784", 20:09:36 INFO - "stage_platform": "linux64-pgo", 20:09:36 INFO - "builduid": "d4d996ce4978400db38ff8dde94cf571", 20:09:36 INFO - "slavebuilddir": "test" 20:09:36 INFO - } 20:09:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:09:36 INFO - Running post-action listener: _resource_record_post_action 20:09:36 INFO - ##### 20:09:36 INFO - ##### Finished read-buildbot-config step (success) 20:09:36 INFO - ##### 20:09:36 INFO - ##### 20:09:36 INFO - ##### Running download-and-extract step. 20:09:36 INFO - ##### 20:09:36 INFO - Running pre-action listener: _resource_record_pre_action 20:09:36 INFO - Running main action method: download_and_extract 20:09:36 INFO - mkdir: /builds/slave/test/build/tests 20:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:36 INFO - https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:39 INFO - Downloaded 1361 bytes. 20:09:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:09:39 INFO - Using the following test package requirements: 20:09:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'jsshell-linux-x86_64.zip'], 20:09:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:39 INFO - https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:40 INFO - Downloaded 24410752 bytes. 20:09:40 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'] 20:09:40 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 20:09:41 INFO - Return code: 0 20:09:41 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 20:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:41 INFO - https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:47 INFO - Downloaded 24410752 bytes. 20:09:47 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'] 20:09:47 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 20:09:48 INFO - Return code: 0 20:09: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')]} 20:09:48 INFO - https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:49 INFO - Downloaded 10834034 bytes. 20:09:49 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'] 20:09:49 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 20:09:49 INFO - Return code: 0 20:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:49 INFO - https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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 20:09:51 INFO - Downloaded 58738925 bytes. 20:09:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:51 INFO - mkdir: /builds/slave/test/properties 20:09:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:51 INFO - Contents: 20:09:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:09:52 INFO - Running post-action listener: _resource_record_post_action 20:09:52 INFO - Running post-action listener: set_extra_try_arguments 20:09:52 INFO - ##### 20:09:52 INFO - ##### Finished download-and-extract step (success) 20:09:52 INFO - ##### 20:09:52 INFO - ##### 20:09:52 INFO - ##### Running populate-webroot step. 20:09:52 INFO - ##### 20:09:52 INFO - Running pre-action listener: _resource_record_pre_action 20:09:52 INFO - Running main action method: populate_webroot 20:09:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:52 INFO - '--tppagecycles', 20:09:52 INFO - '7'], 20:09:52 INFO - 'tests': ['tsvgm']}}, 20:09:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['damp', 'tps']}, 20:09:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'tests': ['damp', 'tps']}, 20:09:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['dromaeo_dom']}, 20:09:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['a11yr', 20:09:52 INFO - 'ts_paint', 20:09:52 INFO - 'tpaint', 20:09:52 INFO - 'sessionrestore', 20:09:52 INFO - 'sessionrestore_no_auto_restore', 20:09:52 INFO - 'tabpaint']}, 20:09:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['tsvgx', 20:09:52 INFO - 'tsvgr_opacity', 20:09:52 INFO - 'tart', 20:09:52 INFO - 'tscrollx', 20:09:52 INFO - 'cart']}, 20:09:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:52 INFO - 'tsvgr_opacity', 20:09:52 INFO - 'tart', 20:09:52 INFO - 'tscrollx', 20:09:52 INFO - 'cart']}, 20:09:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'talos_options': ['--disable-e10s'], 20:09:52 INFO - 'tests': ['tp5o']}, 20:09:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'tests': ['tp5o']}, 20:09:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'talos_options': ['--disable-e10s', 20:09:52 INFO - '--xperf_path', 20:09:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:52 INFO - 'tests': ['tp5n']}, 20:09:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:52 INFO - 'talos_options': ['--xperf_path', 20:09:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:52 INFO - 'tests': ['tp5n']}}, 20:09:52 INFO - 'talos.zip': {'path': '', 20:09:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:52 INFO - Running post-action listener: _resource_record_post_action 20:09:52 INFO - ##### 20:09:52 INFO - ##### Finished populate-webroot step (success) 20:09:52 INFO - ##### 20:09:52 INFO - ##### 20:09:52 INFO - ##### Running create-virtualenv step. 20:09:52 INFO - ##### 20:09:52 INFO - Running pre-action listener: _resource_record_pre_action 20:09:52 INFO - Running main action method: create_virtualenv 20:09:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:52 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 20:09:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:52 INFO - Using real prefix '/usr' 20:09:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:54 INFO - Installing pip.................done. 20:09:54 INFO - Return code: 0 20:09:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:09:54 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 20:09:54 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 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:54 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 20:09:54 INFO - Cleaning up... 20:09:54 INFO - Return code: 0 20:09:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:09:54 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 20:09:54 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 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:55 INFO - Downloading/unpacking psutil>=3.1.1 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:57 INFO - Installing collected packages: psutil 20:09:57 INFO - Running setup.py install for psutil 20:09:57 INFO - building 'psutil._psutil_linux' extension 20:09:57 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 20:09:57 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 20:09:57 INFO - building 'psutil._psutil_posix' extension 20:09:57 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 20:09:57 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 20:09:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:57 INFO - Successfully installed psutil 20:09:57 INFO - Cleaning up... 20:09:57 INFO - Return code: 0 20:09:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:57 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')]} 20:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 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')]} 20:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:09:57 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 20:09:57 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 20:09:57 INFO - Using env: {'DISPLAY': ':0', 20:09:57 INFO - 'HOME': '/home/cltbld', 20:09:57 INFO - 'LANG': 'en_US.UTF-8', 20:09:57 INFO - 'LANGUAGE': 'en_US:en', 20:09:57 INFO - 'LOGNAME': 'cltbld', 20:09:57 INFO - 'MAIL': '/var/mail/cltbld', 20:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:57 INFO - 'MOZ_NO_REMOTE': '1', 20:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:57 INFO - 'NO_EM_RESTART': '1', 20:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:57 INFO - 'PWD': '/builds/slave/test', 20:09:57 INFO - 'SHELL': '/bin/bash', 20:09:57 INFO - 'SHLVL': '1', 20:09:57 INFO - 'TERM': 'linux', 20:09:57 INFO - 'TMOUT': '86400', 20:09:57 INFO - 'USER': 'cltbld', 20:09:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:57 INFO - '_': '/tools/buildbot/bin/python'} 20:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:59 INFO - Installing collected packages: mozsystemmonitor 20:09:59 INFO - Running setup.py install for mozsystemmonitor 20:09:59 INFO - Successfully installed mozsystemmonitor 20:09:59 INFO - Cleaning up... 20:09:59 INFO - Return code: 0 20:09:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:59 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:09:59 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 20:09:59 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 20:09:59 INFO - Using env: {'DISPLAY': ':0', 20:09:59 INFO - 'HOME': '/home/cltbld', 20:09:59 INFO - 'LANG': 'en_US.UTF-8', 20:09:59 INFO - 'LANGUAGE': 'en_US:en', 20:09:59 INFO - 'LOGNAME': 'cltbld', 20:09:59 INFO - 'MAIL': '/var/mail/cltbld', 20:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:59 INFO - 'MOZ_NO_REMOTE': '1', 20:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:59 INFO - 'NO_EM_RESTART': '1', 20:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:59 INFO - 'PWD': '/builds/slave/test', 20:09:59 INFO - 'SHELL': '/bin/bash', 20:09:59 INFO - 'SHLVL': '1', 20:09:59 INFO - 'TERM': 'linux', 20:09:59 INFO - 'TMOUT': '86400', 20:09:59 INFO - 'USER': 'cltbld', 20:09:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:59 INFO - '_': '/tools/buildbot/bin/python'} 20:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:10:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 INFO - Downloading docopt-0.6.1.tar.gz 20:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:02 INFO - Running setup.py install for blobuploader 20:10:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:10:02 INFO - Running setup.py install for requests 20:10:03 INFO - Running setup.py install for docopt 20:10:03 INFO - Successfully installed blobuploader requests docopt 20:10:03 INFO - Cleaning up... 20:10:03 INFO - Return code: 0 20:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:03 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:10:03 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 20:10:03 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 20:10:03 INFO - Using env: {'DISPLAY': ':0', 20:10:03 INFO - 'HOME': '/home/cltbld', 20:10:03 INFO - 'LANG': 'en_US.UTF-8', 20:10:03 INFO - 'LANGUAGE': 'en_US:en', 20:10:03 INFO - 'LOGNAME': 'cltbld', 20:10:03 INFO - 'MAIL': '/var/mail/cltbld', 20:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:03 INFO - 'MOZ_NO_REMOTE': '1', 20:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:03 INFO - 'NO_EM_RESTART': '1', 20:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:03 INFO - 'PWD': '/builds/slave/test', 20:10:03 INFO - 'SHELL': '/bin/bash', 20:10:03 INFO - 'SHLVL': '1', 20:10:03 INFO - 'TERM': 'linux', 20:10:03 INFO - 'TMOUT': '86400', 20:10:03 INFO - 'USER': 'cltbld', 20:10:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:03 INFO - '_': '/tools/buildbot/bin/python'} 20:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:03 INFO - Running setup.py (path:/tmp/pip-2992oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:03 INFO - Running setup.py (path:/tmp/pip-P_U7Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:03 INFO - Running setup.py (path:/tmp/pip-uP_YTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:03 INFO - Running setup.py (path:/tmp/pip-zAe0hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:03 INFO - Running setup.py (path:/tmp/pip-EDsl1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:04 INFO - Running setup.py (path:/tmp/pip-3nCmdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:04 INFO - Running setup.py (path:/tmp/pip-1QvR3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:04 INFO - Running setup.py (path:/tmp/pip-JXqGkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:04 INFO - Running setup.py (path:/tmp/pip-DBztXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:04 INFO - Running setup.py (path:/tmp/pip-cb2w28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:04 INFO - Running setup.py (path:/tmp/pip-qjBGLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:04 INFO - Running setup.py (path:/tmp/pip-KPYxp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:04 INFO - Running setup.py (path:/tmp/pip-4XCnfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:04 INFO - Running setup.py (path:/tmp/pip-4E5nrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:04 INFO - Running setup.py (path:/tmp/pip-OwEQKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:04 INFO - Running setup.py (path:/tmp/pip-WmQYdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:04 INFO - Running setup.py (path:/tmp/pip-tu3GWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:04 INFO - Running setup.py install for manifestparser 20:10:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:10:04 INFO - Running setup.py install for mozcrash 20:10:05 INFO - Running setup.py install for mozdebug 20:10:05 INFO - Running setup.py install for mozdevice 20:10:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Running setup.py install for mozfile 20:10:05 INFO - Running setup.py install for mozhttpd 20:10:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Running setup.py install for mozinfo 20:10:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Running setup.py install for mozInstall 20:10:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Running setup.py install for mozleak 20:10:05 INFO - Running setup.py install for mozlog 20:10:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Running setup.py install for moznetwork 20:10:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Running setup.py install for mozprocess 20:10:06 INFO - Running setup.py install for mozprofile 20:10:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Running setup.py install for mozrunner 20:10:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Running setup.py install for mozscreenshot 20:10:06 INFO - Running setup.py install for moztest 20:10:06 INFO - Running setup.py install for mozversion 20:10:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:06 INFO - Cleaning up... 20:10:06 INFO - Return code: 0 20:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:06 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')]} 20:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:06 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')]} 20:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:06 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:10:06 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 20:10:06 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 20:10:06 INFO - Using env: {'DISPLAY': ':0', 20:10:06 INFO - 'HOME': '/home/cltbld', 20:10:06 INFO - 'LANG': 'en_US.UTF-8', 20:10:06 INFO - 'LANGUAGE': 'en_US:en', 20:10:06 INFO - 'LOGNAME': 'cltbld', 20:10:06 INFO - 'MAIL': '/var/mail/cltbld', 20:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:06 INFO - 'MOZ_NO_REMOTE': '1', 20:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:06 INFO - 'NO_EM_RESTART': '1', 20:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:06 INFO - 'PWD': '/builds/slave/test', 20:10:06 INFO - 'SHELL': '/bin/bash', 20:10:06 INFO - 'SHLVL': '1', 20:10:06 INFO - 'TERM': 'linux', 20:10:06 INFO - 'TMOUT': '86400', 20:10:06 INFO - 'USER': 'cltbld', 20:10:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:06 INFO - '_': '/tools/buildbot/bin/python'} 20:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:06 INFO - Running setup.py (path:/tmp/pip-F5GY7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:06 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)) 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:06 INFO - Running setup.py (path:/tmp/pip-mmmb0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:07 INFO - Running setup.py (path:/tmp/pip-CGPJQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:07 INFO - Running setup.py (path:/tmp/pip-lQYekw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:07 INFO - Running setup.py (path:/tmp/pip-5xHT7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:07 INFO - Running setup.py (path:/tmp/pip-ezNIYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:07 INFO - Running setup.py (path:/tmp/pip-Yrnebg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:07 INFO - Running setup.py (path:/tmp/pip-03XEyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:07 INFO - Running setup.py (path:/tmp/pip-BSZXJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:07 INFO - Running setup.py (path:/tmp/pip-iM_SY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:07 INFO - Running setup.py (path:/tmp/pip-eKEhCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:07 INFO - Running setup.py (path:/tmp/pip-ORfv0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:07 INFO - Running setup.py (path:/tmp/pip-1F1wb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:07 INFO - Running setup.py (path:/tmp/pip-PjIwNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:07 INFO - Running setup.py (path:/tmp/pip-AU3eBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:07 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)) 20:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:07 INFO - Running setup.py (path:/tmp/pip-H1RoyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:08 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)) 20:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:08 INFO - Running setup.py (path:/tmp/pip-TdY38D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:08 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)) 20:10:08 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)) 20:10:08 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)) 20:10:08 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)) 20:10:08 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)) 20:10:08 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)) 20:10:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:09 INFO - Downloading blessings-1.6.tar.gz 20:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:10 INFO - Installing collected packages: blessings 20:10:10 INFO - Running setup.py install for blessings 20:10:10 INFO - Successfully installed blessings 20:10:10 INFO - Cleaning up... 20:10:10 INFO - Return code: 0 20:10:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:10 INFO - Reading from file tmpfile_stdout 20:10:10 INFO - Current package versions: 20:10:10 INFO - argparse == 1.2.1 20:10:10 INFO - blessings == 1.6 20:10:10 INFO - blobuploader == 1.2.4 20:10:10 INFO - docopt == 0.6.1 20:10:10 INFO - manifestparser == 1.1 20:10:10 INFO - mozInstall == 1.12 20:10:10 INFO - mozcrash == 0.17 20:10:10 INFO - mozdebug == 0.1 20:10:10 INFO - mozdevice == 0.48 20:10:10 INFO - mozfile == 1.2 20:10:10 INFO - mozhttpd == 0.7 20:10:10 INFO - mozinfo == 0.9 20:10:10 INFO - mozleak == 0.1 20:10:10 INFO - mozlog == 3.2 20:10:10 INFO - moznetwork == 0.27 20:10:10 INFO - mozprocess == 0.22 20:10:10 INFO - mozprofile == 0.28 20:10:10 INFO - mozrunner == 6.11 20:10:10 INFO - mozscreenshot == 0.1 20:10:10 INFO - mozsystemmonitor == 0.3 20:10:10 INFO - moztest == 0.7 20:10:10 INFO - mozversion == 1.4 20:10:10 INFO - psutil == 3.1.1 20:10:10 INFO - requests == 1.2.3 20:10:10 INFO - wsgiref == 0.1.2 20:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:10 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')]} 20:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 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')]} 20:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:10:10 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 20:10:10 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 20:10:10 INFO - Using env: {'DISPLAY': ':0', 20:10:10 INFO - 'HOME': '/home/cltbld', 20:10:10 INFO - 'LANG': 'en_US.UTF-8', 20:10:10 INFO - 'LANGUAGE': 'en_US:en', 20:10:10 INFO - 'LOGNAME': 'cltbld', 20:10:10 INFO - 'MAIL': '/var/mail/cltbld', 20:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:10 INFO - 'MOZ_NO_REMOTE': '1', 20:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:10 INFO - 'NO_EM_RESTART': '1', 20:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:10 INFO - 'PWD': '/builds/slave/test', 20:10:10 INFO - 'SHELL': '/bin/bash', 20:10:10 INFO - 'SHLVL': '1', 20:10:10 INFO - 'TERM': 'linux', 20:10:10 INFO - 'TMOUT': '86400', 20:10:10 INFO - 'USER': 'cltbld', 20:10:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:10 INFO - '_': '/tools/buildbot/bin/python'} 20:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 INFO - Cleaning up... 20:10:10 INFO - Return code: 0 20:10:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:10 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')]} 20:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 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')]} 20:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:10:10 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 20:10:10 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 20:10:10 INFO - Using env: {'DISPLAY': ':0', 20:10:10 INFO - 'HOME': '/home/cltbld', 20:10:10 INFO - 'LANG': 'en_US.UTF-8', 20:10:10 INFO - 'LANGUAGE': 'en_US:en', 20:10:10 INFO - 'LOGNAME': 'cltbld', 20:10:10 INFO - 'MAIL': '/var/mail/cltbld', 20:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:10 INFO - 'MOZ_NO_REMOTE': '1', 20:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:10 INFO - 'NO_EM_RESTART': '1', 20:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:10 INFO - 'PWD': '/builds/slave/test', 20:10:10 INFO - 'SHELL': '/bin/bash', 20:10:10 INFO - 'SHLVL': '1', 20:10:10 INFO - 'TERM': 'linux', 20:10:10 INFO - 'TMOUT': '86400', 20:10:10 INFO - 'USER': 'cltbld', 20:10:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:10 INFO - '_': '/tools/buildbot/bin/python'} 20:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:10 INFO - Downloading/unpacking jsonschema 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:13 INFO - warning: no files found matching '*.txt' 20:10:13 INFO - no previously-included directories found matching 'build' 20:10:13 INFO - no previously-included directories found matching 'dist' 20:10:13 INFO - no previously-included directories found matching '.git*' 20:10:13 INFO - Installing collected packages: jsonschema, functools32 20:10:13 INFO - Running setup.py install for functools32 20:10:13 INFO - warning: no files found matching '*.txt' 20:10:13 INFO - no previously-included directories found matching 'build' 20:10:13 INFO - no previously-included directories found matching 'dist' 20:10:13 INFO - no previously-included directories found matching '.git*' 20:10:13 INFO - Successfully installed jsonschema functools32 20:10:13 INFO - Cleaning up... 20:10:13 INFO - Return code: 0 20:10:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:13 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 0x7fe40ca77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd41770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', '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 20:10:13 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 20:10:13 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 20:10:13 INFO - Using env: {'DISPLAY': ':0', 20:10:13 INFO - 'HOME': '/home/cltbld', 20:10:13 INFO - 'LANG': 'en_US.UTF-8', 20:10:13 INFO - 'LANGUAGE': 'en_US:en', 20:10:13 INFO - 'LOGNAME': 'cltbld', 20:10:13 INFO - 'MAIL': '/var/mail/cltbld', 20:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:13 INFO - 'MOZ_NO_REMOTE': '1', 20:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:13 INFO - 'NO_EM_RESTART': '1', 20:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:13 INFO - 'PWD': '/builds/slave/test', 20:10:13 INFO - 'SHELL': '/bin/bash', 20:10:13 INFO - 'SHLVL': '1', 20:10:13 INFO - 'TERM': 'linux', 20:10:13 INFO - 'TMOUT': '86400', 20:10:13 INFO - 'USER': 'cltbld', 20:10:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:13 INFO - '_': '/tools/buildbot/bin/python'} 20:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:13 INFO - Downloading/unpacking flake8 20:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:10:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:10:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:16 INFO - no previously-included directories found matching 'docs/_build' 20:10:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:10:16 INFO - Running setup.py install for pep8 20:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:16 INFO - no previously-included directories found matching 'docs/_build' 20:10:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:10:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:10:16 INFO - Cleaning up... 20:10:16 INFO - Return code: 0 20:10:16 INFO - Running post-action listener: _resource_record_post_action 20:10:16 INFO - Running post-action listener: _start_resource_monitoring 20:10:16 INFO - Starting resource monitoring. 20:10:16 INFO - ##### 20:10:16 INFO - ##### Finished create-virtualenv step (success) 20:10:16 INFO - ##### 20:10:16 INFO - ##### 20:10:16 INFO - ##### Running install step. 20:10:16 INFO - ##### 20:10:16 INFO - Running pre-action listener: _resource_record_pre_action 20:10:16 INFO - Running main action method: install 20:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:16 INFO - Reading from file tmpfile_stdout 20:10:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:16 INFO - Reading from file tmpfile_stdout 20:10:16 INFO - Output received: 20:10:16 INFO - Usage: mozinstall [options] installer 20:10:16 INFO - Options: 20:10:16 INFO - -h, --help show this help message and exit 20:10:16 INFO - -d DEST, --destination=DEST 20:10:16 INFO - Directory to install application into. [default: 20:10:16 INFO - "/builds/slave/test"] 20:10:16 INFO - --app=APP Application being installed. [default: firefox] 20:10:16 INFO - mkdir: /builds/slave/test/build/application 20:10:16 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'] 20:10:16 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 20:10:33 INFO - Reading from file tmpfile_stdout 20:10:33 INFO - Output received: 20:10:33 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:33 INFO - Running post-action listener: _resource_record_post_action 20:10:33 INFO - ##### 20:10:33 INFO - ##### Finished install step (success) 20:10:33 INFO - ##### 20:10:33 INFO - ##### 20:10:33 INFO - ##### Running run-tests step. 20:10:33 INFO - ##### 20:10:33 INFO - Running pre-action listener: _resource_record_pre_action 20:10:33 INFO - Running main action method: run_tests 20:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:33 INFO - Python 2.7.3 20:10:33 INFO - Return code: 0 20:10:33 INFO - grabbing minidump binary from tooltool 20:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:33 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 0xdd09c0>, '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 0xdd18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdd1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:33 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 20:10:33 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 20:10:33 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 20:10:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:33 INFO - Return code: 0 20:10:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:10:34 INFO - Return code: 0 20:10:34 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/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 20:10:34 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/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 20:10:34 INFO - Using env: {'DISPLAY': ':0', 20:10:34 INFO - 'HOME': '/home/cltbld', 20:10:34 INFO - 'LANG': 'en_US.UTF-8', 20:10:34 INFO - 'LANGUAGE': 'en_US:en', 20:10:34 INFO - 'LOGNAME': 'cltbld', 20:10:34 INFO - 'MAIL': '/var/mail/cltbld', 20:10:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:34 INFO - 'MOZ_NO_REMOTE': '1', 20:10:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:34 INFO - 'NO_EM_RESTART': '1', 20:10:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:34 INFO - 'PWD': '/builds/slave/test', 20:10:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:34 INFO - 'SHELL': '/bin/bash', 20:10:34 INFO - 'SHLVL': '1', 20:10:34 INFO - 'TERM': 'linux', 20:10:34 INFO - 'TMOUT': '86400', 20:10:34 INFO - 'USER': 'cltbld', 20:10:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092', 20:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:34 INFO - '_': '/tools/buildbot/bin/python'} 20:10:34 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/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 20:10:34 INFO - mozversion application_buildid: 20160527173012 20:10:34 INFO - mozversion application_changeset: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 20:10:34 INFO - mozversion application_display_name: Nightly 20:10:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:34 INFO - mozversion application_name: Firefox 20:10:34 INFO - mozversion application_remotingname: firefox 20:10:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:34 INFO - mozversion application_vendor: Mozilla 20:10:34 INFO - mozversion application_version: 49.0a1 20:10:34 INFO - mozversion platform_buildid: 20160527173012 20:10:34 INFO - mozversion platform_changeset: 1bd815acf6d3d51ded73a0ffbe05bd8a2c515784 20:10:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:34 INFO - mozversion platform_version: 49.0a1 20:10:34 INFO - using testdate: 1464405034 20:10:34 INFO - actual date: 1464405034 20:10:34 INFO - starting webserver on 'localhost:48211' 20:10:34 INFO - SUITE-START | Running 2 tests 20:10:34 INFO - TEST-START | dromaeo_css 20:10:34 INFO - operating with platform_type : linux_ 20:10:34 INFO - Initialising browser for dromaeo_css test... 20:10:34 INFO - TEST-INFO | started process 24045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWCp6uo/profile http://localhost:48211/getInfo.html) 20:10:38 INFO - PROCESS | 24045 | __metrics Screen width/height:1600/1200 20:10:38 INFO - PROCESS | 24045 | colorDepth:24 20:10:38 INFO - PROCESS | 24045 | Browser inner width/height: 1024/697 20:10:38 INFO - PROCESS | 24045 | __metrics 20:10:39 ERROR - PROCESS | 24045 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:10:40 INFO - TEST-INFO | 24045: exit 0 20:10:40 INFO - Browser initialized. 20:10:40 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:40 INFO - TEST-INFO | started process 24126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWCp6uo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:51 INFO - PROCESS | 24126 | RSS: Main: 155049984 20:10:51 INFO - PROCESS | 24126 | 20:11:42 INFO - PROCESS | 24126 | 1464405102594 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] 20:13:51 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48211/tests/dromaeo/cssquery-ext.html) 20:13:52 INFO - PROCESS | 24126 | RSS: Main: 272175104 20:13:52 INFO - PROCESS | 24126 | 20:16:54 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-ext.html (next: http://localhost:48211/tests/dromaeo/cssquery-jquery.html) 20:16:55 INFO - PROCESS | 24126 | RSS: Main: 241451008 20:16:55 INFO - PROCESS | 24126 | 20:19:57 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48211/tests/dromaeo/cssquery-mootools.html) 20:19:57 INFO - PROCESS | 24126 | RSS: Main: 246267904 20:19:57 INFO - PROCESS | 24126 | 20:22:59 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48211/tests/dromaeo/cssquery-prototype.html) 20:23:00 INFO - PROCESS | 24126 | RSS: Main: 231473152 20:23:00 INFO - PROCESS | 24126 | 20:26:03 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48211/tests/dromaeo/cssquery-yui.html) 20:26:03 INFO - PROCESS | 24126 | RSS: Main: 227995648 20:26:03 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | Cycle 1(1): loaded http://localhost:48211/tests/dromaeo/cssquery-yui.html (next: http://localhost:48211/tests/dromaeo/cssquery-dojo.html) 20:29:06 INFO - PROCESS | 24126 | RSS: Main: 272826368 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | __start_tp_report 20:29:06 INFO - PROCESS | 24126 | _x_x_mozilla_page_load 20:29:06 INFO - PROCESS | 24126 | _x_x_mozilla_page_load_details 20:29:06 INFO - PROCESS | 24126 | |i|pagename|runs| 20:29:06 INFO - PROCESS | 24126 | |0;dojo.html;3119.8752049918003;3123.45339565576;3155.5739975103356;3166.6200055993286;3186.330870517191;5215.374155101393;5304.310439642841;5370.355557333116;5434.967356202319;5435.048866448371;5345.465453454663;5359.464053594638;5419.566434685225;5453.018456677796;5499.175123731442;4763.642726795487;4845.588125009361;4855.5872750816225;4860.441049279343;5047.570956468705;4927.7536123193695;4943.406791185045;4976.203807390818;4978.77595508203;5004.62465315101;4755.239161734124;4797.808087676489;4803.231482962727;4850.6362022848425;4861.0277944411255;4839.758012099416;4843.56407923285;4849.806007759686;4851.660383773102;4854.441739200002;4787.281907713836;4808.0383923215495;4820.542048505386;4832.178529649933;4907.362042934431;5325.8934821303355;5381.165919282517;5385.272988146589;5395;5399.62202645815;5875.030619947704;5882.499987501067;5884.970575147139;5885.234919460443;5889.970550147222;5736.368999410061;5771.394003629601;5795.101759227285;5835.358110607872;5896.086106653475;5462.6995515246645;5499;5501.119820828688;5503.724813759296;5505.587080968943;5727.4845263926445;6015.3383127855905;6020.879582408327;6025.246844144482;6027.758889644453;5666.603337766399;5733.996550603628;5743.8564035899435;5746.626469279484;5750.539956803445;5819.94180058194;5866.853328666817;5875;5875.236219291465;5878.911816322759;5623.859403514863;5754.9424505754405;5804.361520232771;5811.389804070596;5819.243498345188;5822.3304320003745;5855.795047173328;5859.44335288147;5859.472647461749;5915.674637894957;4453.309736990772;4454.977725111418;4456.153330867125;4457.041736026705;4459.754713490789;3908.7068469864307;3913.3934240192816;3965;3970.4242884781543;4034.1326614777963;5491.395946445888;5515.283013208337;5518.310211223597;5519.420460851553;5520.033994051025;5895.823125306248;5895.882082358329;5898.203742494794;5903.173555702205;5940.31686356066;5343.946560534423;5449.5640348772;5501.889962200734;5506.33923929123;5553.8333849984565;5004.699718016931;5042.697438153723;5043.621728370314;5045.596352291808;5055.646104772631;5962.463378295887;6003.609765365325;6030.668313242726;6043.909341359883;6068.423499767515;5669.688167150846;5853.239078919713;5868.94131058684;5906.26171728534;5921.259842519685;5963.612365196248;6010.9699451502465;6019.548533860066;6036.698165091816;6052.364501727256;5628.437156284339;5753.280839895013;5761.452661997104;5764.942350576441;5766.135079738073;5847.06446968483;5851.385604511465;5906.763729450774;5911.261092363455;5920.052791553331;5749.540036796962;5793.131030345482;5793.710314484343;5796.913046304225;5802.622829516068;5578.497935185853;5678.659280443187;5743.0811070228565;5751.338596061507;5755.625884317674;5631.1271752878365;5691.630044047124;5696.11710184922;5699.829005129853;5746.913796292975;5805.448482394166;5815.273090863642;5872.647641141545;5873.823785286449;5875.294964604275;5437.564994800327;5568.220449137205;5595.748191331319;5605.383407825055;5699.971500142473 20:29:06 INFO - PROCESS | 24126 | |1;ext.html;581.1689284323419;615.3354377272544;631.1038325577679;639.6737663791466;645.1033064040987;30659.540106898385;31161.376772464566;42252.788736056355;42940;43030.139397212035;41149.17701645965;45606;45659;45661.77169114158;45674.31488527675;8702.65189392425;8900.421472604292;8903;8906.153915378029;8907.376483646147;8652.307815374756;8793.428427152214;8793.824123517526;8795.340349473783;8801.427907186044;8827.691030813923;8856.335774816882;8863.734087977371;8875.68935087272;8883.022867484571;8737.432066915662;8771.254443372321;8782.64869405223;8783.780405489882;8791.340649451253;8402.45384050041;8460.746177614681;8485.151484851527;8501.06488286288;8507.106753790888;42194;42440;42581.57418425838;42588.36117458241;42701;3453.7611888198967;3584.623614520464;3918.902027449308;3958.4853968984135;4120.75275483472;31940.520892186636;32034;32431.51352729711;34074;34189.316213675585;4215.59951804578;4263.488381394252;4268.295731204347;4291.892702682427;4407.867763967086;331559;334426.32786836155;334627;334720;335851;57549.42450575525;57703;57709.13436298459;57845.42154578485;57989;60989.39010609837;61205.387946120856;61385.386146137964;61443.38556614466;61460;14180.078294910798;16162.272697728631;16327.510174694778;16548.669026619402;16566.420175293806;12370.690732731573;12496.187747796364;12502.624921252376;12503.124781265406;12503.249805011728;15422.305996230196;17100.91449542744;17122.486325410257;17175.656486870193;17214.39749608758;5680.687562184037;6410.8076757697345;6646.60120392778;6893.896591551131;6987.6855541499735;978.3200675530438;1035.9585616575253;1067.882532921378;1110.428129513285;1117.2291119127776;32150.517742233886;32472.188195294835;32569;32592.674073258964;33045.339093218485;1085.5574956348216;1131.4569006876582;1171.9920868053466;1268.0806415348798;1287.3370214339623;16238.188090595659;17113.20830167555;17347;17781.19984600696;17823.10884455772;524886;529352;529777;530315;532480;59110;59178.40821591729;59302.11046834301;59332;59411;1330.7538105450524;1388.4862600837553;1409.1615488784157;1410.2135765469952;1416.2493878244547;31710.524342135348;32806.67193328036;32875;32985.67014329922;33602.66397336093;50478.24282635837;50544.49455505545;50908.490915091854;50915.49084509256;50935.745321273156;344792;346492;346642.06715866044;347172;349290;22967.77032229723;23605.173818916257;27463.725362746118;27556.44887102287;27913.162605121877;47028;47518;47678;48164;48614;39551.60448395479;40665.59334406618;40712.38931415972;41337.79331103325;41651.166976660905;39132.41301380539;39877.2024559513;40034.199316012935;40224.798876005436;41014.58985410227;40114;41038;41132.38301425541;41169.1766164681;41233.1753364937;34129.31741365208;34703;35454.11364715903;35675.82162089173;36278.637213627524;26935.730642694107;27271;27650.86174569114;27782.861085694443;27801 20:29:06 INFO - PROCESS | 24126 | |2;jquery.html;386.4512392402789;397.6182864450129;404.2198556785407;405.1471652172178;405.17142443702625;13860.84448202118;16890.74663880043;18517.16672749726;19206.42380728577;19206.807931920695;15112.622184445394;17728.37950671727;18408.63182736348;19047.238110475566;19387.127579258933;5590.944090559104;5765.221695071154;5767.884642307173;5768.077107662775;5793.855153621151;4210.410542524034;5631.4087020862835;5686;6040.66776327304;6374.936250637481;6362.618242905417;6389.393007664265;6407.839804004914;6421.389967953037;6421.743130274784;6176.629402235858;6318.304986451487;6380.7876503464195;6386.169797926286;6388.7125079371535;5456.590755693339;5589.105743081128;5595.18869763882;5624.437556244384;5639.577031722637;22166.335009949566;22752;23033.19383821575;23053.7694623055;23173.188938387077;2326.3951372643064;2498.7126480454617;2545.618157276405;2591.2226332100295;2599.6230546570832;14066.437342506288;14080.788788168185;14227.573172804832;14333.78499322511;14834.629134271621;1935.129191863667;2003.2888324644687;2064.834813214939;2079.656856618656;2104.852660313779;75915;78102.21897781006;79090;79779;80917;10397.584096636201;10479.947600262103;10526.473676316307;10707.946460267805;10814.513346899408;14323.498677546237;14359.78460323096;14831.258437078102;14892.553223403314;14926.179060151795;8021.197880212048;8194.918050819535;8250.257476827115;8306.958465207756;8376.078631350547;6253.1245625612455;8006.679732810622;8024.277814996678;8136.471129376571;8202.58987050645;6018.969905150446;6333.904991425133;6359.17330747;6416.326285740023;6498.967505162444;1797.7752780902388;1843.889366638006;1861.2275905499337;1884.4629280655222;1903.742994695726;405.40000798817914;407.97960101995375;421.1639894808802;425.3874420834051;1027.0397178637847;11427.200095993201;11899.107566932515;17495.82504174942;18708.625827483374;20304.89847550753;964.6141543382703;983.4640121133999;999.9700008999741;1000.9949950250348;1001.4942454060798;7926.841463170705;10948.945255273673;10950.671479855617;10988.780224395467;10994.120470362352;496322;498359;498509;502764;502789;95383.52308238414;97015.51492242493;97255.02744972601;97664;97801.51099244601;1044.9164066874632;1050.2753100360726;1069.5828626835385;1082.3127314155568;1083.842842787807;16861.91569042196;16989.320427182774;17170.39903603368;17257.223424945656;17513.912430437766;39210.60789392069;41241.793791030854;41307.58692413037;41765.58234417617;42074.15851682888;56636;57445.42554574401;58515;58522.7073864645;58987.41012589819;6772.665261069081;7557.924420755942;8518.403711740119;8601.870971935552;8910.732678019669;10905.291156075147;12210.389480526115;13327.533536326182;13327.933360333524;13419.261940593362;11730.472128754398;11800.17398782077;11888.28670279786;11952;12133.878661213275;11393.430328483377;11587.246828956091;11763.058955283386;11928.403579821148;11932.1050921183;11785.88214117848;11947.880521195024;11955.64133076009;12154.392280385768;12304.384780760747;8682.43564168327;8735.082816304452;8767.473951562926;8835.867461987948;9061.365704400629;11968.281903085843;12011.339376334385;12103.152779305365;12131.45408456604;12196.451159698012 20:29:06 INFO - PROCESS | 24126 | |3;mootools.html;1304.2109523738131;1495.8803295736343;1528.0526073834221;1667.491415118389;1796;8429.325653947684;8843.557822108893;8861.113888611135;9096.772580685487;9099.727008189764;8860.689875854347;9046.09539046095;9051.547422628859;9057.50183739894;9062.728118156449;2075.7301550798375;2273.533925545259;2336.5560543496767;2348.941276468089;2383.690120284369;2336.4509340305017;2338.088145623208;2341.028473183627;2341.4146463384154;2341.555104530142;2297.2304278066786;2340.789328960393;2344.554534638422;2345.2495201535517;2346.8005219556358;2023.9190432382686;2248.8650680959195;2310.6302991521443;2328;2333.265021518216;2310.976890231093;2337.135259953828;2343.355577216279;2347.6361164019604;2347.7886990170796;8858.069902660192;8918.19736223743;8927;8959;9010.549472526347;4990.925136122961;5137.049645815536;5138.229265610151;5142.280080788692;5144.948550514484;3436.9656303437146;3548.3435564420406;3560.590532088817;3600.513930619385;3659.4144936809985;1184.135581025856;1200.0759415250209;1233.407964177191;1242.0994778785398;1246.0529997202102;12755.42600582976;12776.297303648296;12777.808332875014;12797.744045119045;12797.744045119138;4735.526447355306;4785.712857228577;4870.4155501339355;4872;4895.069936712013;9575.760605984906;9575.952120239494;9606.519674016272;9619.903800961902;9621.951890240503;4644.071185762861;5152.793888244503;5161.922571161435;5162.045021671003;5165.811863271469;4878.731669758197;4986.4514903360605;4995.600351971906;5034.244863270465;5040.168372218543;3783.281176576442;3890.6498415142773;3905.8047097645003;3913.7847418391693;3988.4017397390044;1132.8130858408435;1141.7316930521322;1145.9369734664506;1153.2676750263474;1163.30201878872;986.7434467038622;991.6182269826169;993.3890657245742;1022.3508072374096;1025.8050970315617;6065.2418447694035;6098.969505152535;6174.876502469925;6208.565400421927;6266.968665156736;432.16376311836694;432.37521781026743;437.9562043795595;443.0474479868309;443.69385124264153;4294.184105020036;4314.245007123741;4315.158544083936;4389.100234451929;4418;10698.144148468104;11087.279326843729;11116.777664446827;11139.721506962229;11143.498542565603;10939.726506837393;11004.614838480615;11028.779424411627;11031.613893513688;11044.226904116635;7995;8207.179282071864;8209;8532.658693652309;8536.402451828437;6168.876622467616;6315.463185629273;6489.7404103835315;6495.545311828127;6591.967040164768;9810.509474526389;9931;9960.103590676585;10287.794244115226;10294.794104118026;10368.42973636427;10384.688459346231;10509.9474502627;10595.841062384225;10726.892731072901;7119.964400177966;7619.733309334147;7813.492123011986;7938.3252423542335;8149;8842.602082906156;8846.424982376126;8869.201771840566;8913.866292005754;8929.285657147282;7639.809004774925;7724.188960159102;7770.456068075407;7868.685252589832;8100.473469224482;7753.224677532202;7941.205879412244;7998.96000520017;8049.315808156372;8142.348612110898;7162.677679504331;7331.3768329692575;7388;7407.444441666788;7408.073990751156;5312.734363281743;5398.1902714593125;5430.647007944471;5516;5529.723513824373;5297.708626025606;5472.50747432733;5534.308211473566;5541.473560011793;5568.777248909998 20:29:06 INFO - PROCESS | 24126 | |4;prototype.html;338.8373580681273;339.7774457730186;345.2456382803576;347.5308333749439;349.8722966117368;5358.732063396834;5367.543758780504;5376.489233522814;5390.436773335728;5408.188771684245;5323.520883120518;5349.304590403242;5365.7585408656605;5378.677279363241;5387.138057910725;4001.8994776436493;4063.5123785145825;4145.523264824538;4170.895727606804;4180.770057646828;4134.896627584304;4155.58444155585;4156.8129434175535;4163.854265100722;4191.658669225849;3977.925959990801;4123.958760412403;4140.544540100586;4174.478190226222;4175.603317684815;4065.817038233272;4164.646005089571;4166.91666166675;4168.478940132483;4183.3515805049965;3688.188598508324;3690.2435000824767;3710.07248187953;3715.442683597482;3716.4611131385795;5180.352455943007;5193.221016847466;5213.817516386908;5235.73821308933;5236.162214045735;4602.355670206174;4816.7832447539595;4834.734089625069;4855.126077306083;4860.125177468054;5623.943760562423;5625.437456254383;5630.40880707528;5637.646964728477;5643.351014633328;4048.210598933209;4051.574584668597;4069.206504731549;4073.6944729145434;4085.938710919309;5582.413846546095;5865.941340586583;5872.383399743051;5877.38456386908;5893.263342082239;4018.83924643011;4020.4170395293104;4024.6176613221696;4062.1469491406547;4070.883140766785;4104.809605214455;4135.58644135584;4137.131202447459;4183.142455796555;4194.119234960632;4683.320918466803;4688.343631891538;4726.621870250372;4752.619790416758;4756.952430475721;5597.328320601472;5607.130894711327;5617.185508101303;5647.696097782761;5669.971650141723;1403.929803509841;1415.5894790510843;1430.4564265579013;1442.783582462639;1443.162965480019;937.8171256604896;941.4022095968973;991.4893829677721;993.4039576254189;1006.3961623026272;5453.64551304164;5472.480114389126;5481.424450432647;5489.862753431116;5491.450854914477;5851.678157701367;5881.264841894763;5899.941000590025;5913.231279933581;5917;5368.812091576776;5388.622796404293;5409.891802164014;5433.375161856437;5441.156620723794;3069.5702601635344;3086.058752080592;3094.7214750672547;3102.844857757103;3110.206897241189;5708.657480551097;5962.5826192167;5976.207137858712;5984.880302393928;6020.712129390803;5871.089981052944;5875.853103672443;5882.970585147047;5896.204012458349;5912.40875912414;5936.168936348915;5938.881222375615;5964.956132676851;5990.311114221833;6005.189299444519;5643.689597072201;5683.460071293221;5734.340550836707;5767.8558036049435;5780.837796786307;5666.348369937345;5722.971385143048;5731;5741.282339707536;5751.568632352507;5694.658320500783;5883.823485295276;6002.939970600238;6031.5476339273855;6040.848978775566;4085.121698834646;4114.938275925803;4119.361498967545;4119.887630339732;4127.823570282455;5548.9722551388595;5577.6653400796085;5761.769529218785;5777.295697769084;5873.823785286449;5650.180723795109;5668.829935101953;5685.545156387562;5687.573431992534;5711;5621.7189140542;5629.577781666309;5648.435156484319;5662.462066103713;5665.546756259407;5355.892882142258;5624.8875022498505;5632.746526406239;5651.406602306699;5671.808920126819;5705.258316418839;5727.799527016535;5740.885182296247;5750.338711048283;5769;5511.972440137773;5648.830535083954;5655.660660360391;5660.490555849993;5681.971590142188 20:29:06 INFO - PROCESS | 24126 | |5;yui.html;745.9440541959355;747.6598147842732;816.3020617372147;854.1373213054817;858.4463021351229;15241.237938103091;15679.764803527942;15763.684726305495;15809.130497822614;15813.367465301402;13959.232242226673;14407.567772966802;14487.420503179861;14557.78163327551;14590.270486475687;804.388664614894;809.7570728781371;820.6676296100089;821.1460081515218;822.2763967708408;814.9388795840335;817.1256755271861;818.1123481023097;818.2799136759672;818.5088946632033;850.0819115355432;850.4982060584254;850.6257246811414;850.8723691446271;851.4550687559966;842.1704620948361;843.877637742527;844.2106630300658;844.5397258494074;845.9577021148949;619.3527763487167;620.2464006232449;620.3424370167637;620.6245221640933;620.7920346683866;13635.795463068062;13686.247256400893;13693.109947853358;13995.720085598232;14658.267086645625;13576.728465430735;13773.655658608515;14315.57053288403;14446.638834029129;14841.257937103102;11325.773484530346;11727.17909746318;11772.705682357924;11829.467673954607;11847.703807404798;3773.641504057138;3777.7166712496673;3791.810409479515;3901.8634347797974;3956.8417263309434;46784.53215467836;50684.49315506835;51999;53499;62641.68679156575;10787.67636970892;11160;11351.318920864775;11360.772784544428;11751.059915206934;19930;19989.20043198285;20000.499987500138;20031.699524507145;20040.498987525138;8541.316694664412;8657.567121643893;8916.73249802507;9118.40730352525;9142.954285228532;4721.645876559203;4830.227163653799;4846.29728689338;4895.8041678332465;5147.7683504242395;3444.6555344465355;3537.7700449470703;3539.3275277697153;3541.94687079694;3542.4686297055646;645.0775391190549;658.9472842172614;659.4592434204003;659.874623821482;665.627248740697;610.4140025575408;661.7882277671099;746.1493896957472;761.5392687424139;795.5187111797279;9570.99504552026;9950.950245248727;9970.302078854556;10020.849687254697;10033.698989030341;583.631384403573;683.2484267305924;700.5656492974286;704.3871831506519;716.989245161323;4357.9128417431475;4632.467266264355;4650.279206722963;4659.508957133752;4689.60138388234;65493.67253163799;67148.6642566784;68727;69001.65499172472;70816.291837082;56643.433565663814;57641.423585764445;59962;60253.39746602478;60604.181874543836;54524.18213726876;54896.725516372164;54909.725451373284;54971.72514137404;55345.44654553483;9250.398724082914;9366.95316523413;9405.81188376215;9433.716988490356;9469.10043545862;36682.816585917964;36954.6304536962;37787.24425511529;37878.2424351517;38205;45854.54145458503;48639.27041094457;48852.26721599108;49349.75325123495;49517;11488.138389620644;11516.567142622274;11549.13381496408;11676.824847627122;11994.400279986141;12756.043296752596;12784;13252.734945300846;13435.328233588087;14080.647983800487;13518.324083795575;13595.660108497366;13876.375563099886;14246.35891384911;14296.213708246147;12882.981912660987;13258.80111798343;13399.749191868033;13493.460261589427;13542.59372218835;12964.675883102998;13302.488135189433;13356.332183390597;13583.660408489866;13882.236476993863;10477.266591338534;10637.521311541153;10715.464226788474;10741.140708743438;11010.229283950046;11066.667999960015;11091.33451992883;11200.719982000515;11270.380129092979;11289.491972861406 20:29:06 INFO - PROCESS | 24126 | __end_tp_report 20:29:06 INFO - PROCESS | 24126 | __start_cc_report 20:29:06 INFO - PROCESS | 24126 | _x_x_mozilla_cycle_collect,925 20:29:06 INFO - PROCESS | 24126 | __end_cc_report 20:29:06 INFO - PROCESS | 24126 | __startTimestamp1464406146877__endTimestamp 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | ------- Summary: start ------- 20:29:06 INFO - PROCESS | 24126 | Number of tests: 6 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#0] dojo.html Cycles:165 Average:5407.67 Median:5631.13 stddev:635.02 (11.3%) stddev-sans-first:611.08 20:29:06 INFO - PROCESS | 24126 | Values: 3119.9 3123.5 3155.6 3166.6 3186.3 5215.4 5304.3 5370.4 5435.0 5435.0 5345.5 5359.5 5419.6 5453.0 5499.2 4763.6 4845.6 4855.6 4860.4 5047.6 4927.8 4943.4 4976.2 4978.8 5004.6 4755.2 4797.8 4803.2 4850.6 4861.0 4839.8 4843.6 4849.8 4851.7 4854.4 4787.3 4808.0 4820.5 4832.2 4907.4 5325.9 5381.2 5385.3 5395.0 5399.6 5875.0 5882.5 5885.0 5885.2 5890.0 5736.4 5771.4 5795.1 5835.4 5896.1 5462.7 5499.0 5501.1 5503.7 5505.6 5727.5 6015.3 6020.9 6025.2 6027.8 5666.6 5734.0 5743.9 5746.6 5750.5 5819.9 5866.9 5875.0 5875.2 5878.9 5623.9 5754.9 5804.4 5811.4 5819.2 5822.3 5855.8 5859.4 5859.5 5915.7 4453.3 4455.0 4456.2 4457.0 4459.8 3908.7 3913.4 3965.0 3970.4 4034.1 5491.4 5515.3 5518.3 5519.4 5520.0 5895.8 5895.9 5898.2 5903.2 5940.3 5343.9 5449.6 5501.9 5506.3 5553.8 5004.7 5042.7 5043.6 5045.6 5055.6 5962.5 6003.6 6030.7 6043.9 6068.4 5669.7 5853.2 5868.9 5906.3 5921.3 5963.6 6011.0 6019.5 6036.7 6052.4 5628.4 5753.3 5761.5 5764.9 5766.1 5847.1 5851.4 5906.8 5911.3 5920.1 5749.5 5793.1 5793.7 5796.9 5802.6 5578.5 5678.7 5743.1 5751.3 5755.6 5631.1 5691.6 5696.1 5699.8 5746.9 5805.4 5815.3 5872.6 5873.8 5875.3 5437.6 5568.2 5595.7 5605.4 5700.0 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#1] ext.html Cycles:180 Average:56845.80 Median:41140.78 stddev:109467.40 (266.1%) stddev-sans-first:109692.98 20:29:06 INFO - PROCESS | 24126 | Values: 581.2 615.3 631.1 639.7 645.1 30659.5 31161.4 42252.8 42940.0 43030.1 41149.2 45606.0 45659.0 45661.8 45674.3 8702.7 8900.4 8903.0 8906.2 8907.4 8652.3 8793.4 8793.8 8795.3 8801.4 8827.7 8856.3 8863.7 8875.7 8883.0 8737.4 8771.3 8782.6 8783.8 8791.3 8402.5 8460.7 8485.2 8501.1 8507.1 42194.0 42440.0 42581.6 42588.4 42701.0 3453.8 3584.6 3918.9 3958.5 4120.8 31940.5 32034.0 32431.5 34074.0 34189.3 4215.6 4263.5 4268.3 4291.9 4407.9 331559.0 334426.3 334627.0 334720.0 335851.0 57549.4 57703.0 57709.1 57845.4 57989.0 60989.4 61205.4 61385.4 61443.4 61460.0 14180.1 16162.3 16327.5 16548.7 16566.4 12370.7 12496.2 12502.6 12503.1 12503.2 15422.3 17100.9 17122.5 17175.7 17214.4 5680.7 6410.8 6646.6 6893.9 6987.7 978.3 1036.0 1067.9 1110.4 1117.2 32150.5 32472.2 32569.0 32592.7 33045.3 1085.6 1131.5 1172.0 1268.1 1287.3 16238.2 17113.2 17347.0 17781.2 17823.1 524886.0 529352.0 529777.0 530315.0 532480.0 59110.0 59178.4 59302.1 59332.0 59411.0 1330.8 1388.5 1409.2 1410.2 1416.2 31710.5 32806.7 32875.0 32985.7 33602.7 50478.2 50544.5 50908.5 50915.5 50935.7 344792.0 346492.0 346642.1 347172.0 349290.0 22967.8 23605.2 27463.7 27556.4 27913.2 47028.0 47518.0 47678.0 48164.0 48614.0 39551.6 40665.6 40712.4 41337.8 41651.2 39132.4 39877.2 40034.2 40224.8 41014.6 40114.0 41038.0 41132.4 41169.2 41233.2 34129.3 34703.0 35454.1 35675.8 36278.6 26935.7 27271.0 27650.9 27782.9 27801.0 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#2] jquery.html Cycles:180 Average:29294.75 Median:2595.42 stddev:82410.71 (3175.2%) stddev-sans-first:82613.31 20:29:06 INFO - PROCESS | 24126 | Values: 386.5 397.6 404.2 405.1 405.2 13860.8 16890.7 18517.2 19206.4 19206.8 15112.6 17728.4 18408.6 19047.2 19387.1 5590.9 5765.2 5767.9 5768.1 5793.9 4210.4 5631.4 5686.0 6040.7 6374.9 6362.6 6389.4 6407.8 6421.4 6421.7 6176.6 6318.3 6380.8 6386.2 6388.7 5456.6 5589.1 5595.2 5624.4 5639.6 22166.3 22752.0 23033.2 23053.8 23173.2 2326.4 2498.7 2545.6 2591.2 2599.6 14066.4 14080.8 14227.6 14333.8 14834.6 1935.1 2003.3 2064.8 2079.7 2104.9 75915.0 78102.2 79090.0 79779.0 80917.0 10397.6 10479.9 10526.5 10707.9 10814.5 14323.5 14359.8 14831.3 14892.6 14926.2 8021.2 8194.9 8250.3 8307.0 8376.1 6253.1 8006.7 8024.3 8136.5 8202.6 6019.0 6333.9 6359.2 6416.3 6499.0 1797.8 1843.9 1861.2 1884.5 1903.7 405.4 408.0 421.2 425.4 1027.0 11427.2 11899.1 17495.8 18708.6 20304.9 964.6 983.5 1000.0 1001.0 1001.5 7926.8 10948.9 10950.7 10988.8 10994.1 496322.0 498359.0 498509.0 502764.0 502789.0 95383.5 97015.5 97255.0 97664.0 97801.5 1044.9 1050.3 1069.6 1082.3 1083.8 16861.9 16989.3 17170.4 17257.2 17513.9 39210.6 41241.8 41307.6 41765.6 42074.2 56636.0 57445.4 58515.0 58522.7 58987.4 6772.7 7557.9 8518.4 8601.9 8910.7 10905.3 12210.4 13327.5 13327.9 13419.3 11730.5 11800.2 11888.3 11952.0 12133.9 11393.4 11587.2 11763.1 11928.4 11932.1 11785.9 11947.9 11955.6 12154.4 12304.4 8682.4 8735.1 8767.5 8835.9 9061.4 11968.3 12011.3 12103.2 12131.5 12196.5 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#3] mootools.html Cycles:180 Average:5890.54 Median:4940.76 stddev:3367.49 (68.2%) stddev-sans-first:3359.30 20:29:06 INFO - PROCESS | 24126 | Values: 1304.2 1495.9 1528.1 1667.5 1796.0 8429.3 8843.6 8861.1 9096.8 9099.7 8860.7 9046.1 9051.5 9057.5 9062.7 2075.7 2273.5 2336.6 2348.9 2383.7 2336.5 2338.1 2341.0 2341.4 2341.6 2297.2 2340.8 2344.6 2345.2 2346.8 2023.9 2248.9 2310.6 2328.0 2333.3 2311.0 2337.1 2343.4 2347.6 2347.8 8858.1 8918.2 8927.0 8959.0 9010.5 4990.9 5137.0 5138.2 5142.3 5144.9 3437.0 3548.3 3560.6 3600.5 3659.4 1184.1 1200.1 1233.4 1242.1 1246.1 12755.4 12776.3 12777.8 12797.7 12797.7 4735.5 4785.7 4870.4 4872.0 4895.1 9575.8 9576.0 9606.5 9619.9 9622.0 4644.1 5152.8 5161.9 5162.0 5165.8 4878.7 4986.5 4995.6 5034.2 5040.2 3783.3 3890.6 3905.8 3913.8 3988.4 1132.8 1141.7 1145.9 1153.3 1163.3 986.7 991.6 993.4 1022.4 1025.8 6065.2 6099.0 6174.9 6208.6 6267.0 432.2 432.4 438.0 443.0 443.7 4294.2 4314.2 4315.2 4389.1 4418.0 10698.1 11087.3 11116.8 11139.7 11143.5 10939.7 11004.6 11028.8 11031.6 11044.2 7995.0 8207.2 8209.0 8532.7 8536.4 6168.9 6315.5 6489.7 6495.5 6592.0 9810.5 9931.0 9960.1 10287.8 10294.8 10368.4 10384.7 10509.9 10595.8 10726.9 7120.0 7619.7 7813.5 7938.3 8149.0 8842.6 8846.4 8869.2 8913.9 8929.3 7639.8 7724.2 7770.5 7868.7 8100.5 7753.2 7941.2 7999.0 8049.3 8142.3 7162.7 7331.4 7388.0 7407.4 7408.1 5312.7 5398.2 5430.6 5516.0 5529.7 5297.7 5472.5 5534.3 5541.5 5568.8 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#4] prototype.html Cycles:180 Average:4748.09 Median:5437.27 stddev:1401.85 (25.8%) stddev-sans-first:1366.16 20:29:06 INFO - PROCESS | 24126 | Values: 338.8 339.8 345.2 347.5 349.9 5358.7 5367.5 5376.5 5390.4 5408.2 5323.5 5349.3 5365.8 5378.7 5387.1 4001.9 4063.5 4145.5 4170.9 4180.8 4134.9 4155.6 4156.8 4163.9 4191.7 3977.9 4124.0 4140.5 4174.5 4175.6 4065.8 4164.6 4166.9 4168.5 4183.4 3688.2 3690.2 3710.1 3715.4 3716.5 5180.4 5193.2 5213.8 5235.7 5236.2 4602.4 4816.8 4834.7 4855.1 4860.1 5623.9 5625.4 5630.4 5637.6 5643.4 4048.2 4051.6 4069.2 4073.7 4085.9 5582.4 5865.9 5872.4 5877.4 5893.3 4018.8 4020.4 4024.6 4062.1 4070.9 4104.8 4135.6 4137.1 4183.1 4194.1 4683.3 4688.3 4726.6 4752.6 4757.0 5597.3 5607.1 5617.2 5647.7 5670.0 1403.9 1415.6 1430.5 1442.8 1443.2 937.8 941.4 991.5 993.4 1006.4 5453.6 5472.5 5481.4 5489.9 5491.5 5851.7 5881.3 5899.9 5913.2 5917.0 5368.8 5388.6 5409.9 5433.4 5441.2 3069.6 3086.1 3094.7 3102.8 3110.2 5708.7 5962.6 5976.2 5984.9 6020.7 5871.1 5875.9 5883.0 5896.2 5912.4 5936.2 5938.9 5965.0 5990.3 6005.2 5643.7 5683.5 5734.3 5767.9 5780.8 5666.3 5723.0 5731.0 5741.3 5751.6 5694.7 5883.8 6002.9 6031.5 6040.8 4085.1 4114.9 4119.4 4119.9 4127.8 5549.0 5577.7 5761.8 5777.3 5873.8 5650.2 5668.8 5685.5 5687.6 5711.0 5621.7 5629.6 5648.4 5662.5 5665.5 5355.9 5624.9 5632.7 5651.4 5671.8 5705.3 5727.8 5740.9 5750.3 5769.0 5512.0 5648.8 5655.7 5660.5 5682.0 20:29:06 INFO - PROCESS | 24126 | 20:29:06 INFO - PROCESS | 24126 | [#5] yui.html Cycles:180 Average:15602.48 Median:4654.89 stddev:18279.35 (392.7%) stddev-sans-first:18296.58 20:29:06 INFO - PROCESS | 24126 | Values: 745.9 747.7 816.3 854.1 858.4 15241.2 15679.8 15763.7 15809.1 15813.4 13959.2 14407.6 14487.4 14557.8 14590.3 804.4 809.8 820.7 821.1 822.3 814.9 817.1 818.1 818.3 818.5 850.1 850.5 850.6 850.9 851.5 842.2 843.9 844.2 844.5 846.0 619.4 620.2 620.3 620.6 620.8 13635.8 13686.2 13693.1 13995.7 14658.3 13576.7 13773.7 14315.6 14446.6 14841.3 11325.8 11727.2 11772.7 11829.5 11847.7 3773.6 3777.7 3791.8 3901.9 3956.8 46784.5 50684.5 51999.0 53499.0 62641.7 10787.7 11160.0 11351.3 11360.8 11751.1 19930.0 19989.2 20000.5 20031.7 20040.5 8541.3 8657.6 8916.7 9118.4 9143.0 4721.6 4830.2 4846.3 4895.8 5147.8 3444.7 3537.8 3539.3 3541.9 3542.5 645.1 658.9 659.5 659.9 665.6 610.4 661.8 746.1 761.5 795.5 9571.0 9951.0 9970.3 10020.8 10033.7 583.6 683.2 700.6 704.4 717.0 4357.9 4632.5 4650.3 4659.5 4689.6 65493.7 67148.7 68727.0 69001.7 70816.3 56643.4 57641.4 59962.0 60253.4 60604.2 54524.2 54896.7 54909.7 54971.7 55345.4 9250.4 9367.0 9405.8 9433.7 9469.1 36682.8 36954.6 37787.2 37878.2 38205.0 45854.5 48639.3 48852.3 49349.8 49517.0 11488.1 11516.6 11549.1 11676.8 11994.4 12756.0 12784.0 13252.7 13435.3 14080.6 13518.3 13595.7 13876.4 14246.4 14296.2 12883.0 13258.8 13399.7 13493.5 13542.6 12964.7 13302.5 13356.3 13583.7 13882.2 10477.3 10637.5 10715.5 10741.1 11010.2 11066.7 11091.3 11200.7 11270.4 11289.5 20:29:06 INFO - PROCESS | 24126 | -------- Summary: end -------- 20:29:06 INFO - PROCESS | 24126 | 20:29:07 INFO - TEST-INFO | 24126: exit 0 20:29:07 INFO - TEST-OK | dromaeo_css | took 1113046ms 20:29:07 INFO - TEST-START | kraken 20:29:07 INFO - operating with platform_type : linux_ 20:29:07 INFO - Initialising browser for kraken test... 20:29:07 INFO - TEST-INFO | started process 24309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgashW/profile http://localhost:48211/getInfo.html) 20:29:11 INFO - PROCESS | 24309 | __metrics Screen width/height:1600/1200 20:29:11 INFO - PROCESS | 24309 | colorDepth:24 20:29:11 INFO - PROCESS | 24309 | Browser inner width/height: 1024/697 20:29:11 INFO - PROCESS | 24309 | __metrics 20:29:12 ERROR - PROCESS | 24309 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:29:13 INFO - TEST-INFO | 24309: exit 0 20:29:13 INFO - Browser initialized. 20:29:13 INFO - Running cycle 1/1 for kraken test... 20:29:13 INFO - TEST-INFO | started process 24389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgashW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:24 INFO - PROCESS | 24389 | RSS: Main: 155250688 20:29:24 INFO - PROCESS | 24389 | 20:29:27 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48211/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:28 INFO - PROCESS | 24389 | RSS: Main: 213757952 20:29:28 INFO - PROCESS | 24389 | 20:29:30 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48211/tests/kraken/driver.html?testName=audio-dft) 20:29:31 INFO - PROCESS | 24389 | RSS: Main: 197484544 20:29:31 INFO - PROCESS | 24389 | 20:29:34 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48211/tests/kraken/driver.html?testName=audio-fft) 20:29:35 INFO - PROCESS | 24389 | RSS: Main: 268079104 20:29:35 INFO - PROCESS | 24389 | 20:29:37 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48211/tests/kraken/driver.html?testName=audio-oscillator) 20:29:37 INFO - PROCESS | 24389 | RSS: Main: 179470336 20:29:37 INFO - PROCESS | 24389 | 20:29:40 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:40 INFO - PROCESS | 24389 | RSS: Main: 183762944 20:29:40 INFO - PROCESS | 24389 | 20:29:43 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48211/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:44 INFO - PROCESS | 24389 | RSS: Main: 217890816 20:29:44 INFO - PROCESS | 24389 | 20:29:47 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48211/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:48 INFO - PROCESS | 24389 | RSS: Main: 219729920 20:29:48 INFO - PROCESS | 24389 | 20:29:50 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48211/tests/kraken/driver.html?testName=json-parse-financial) 20:29:51 INFO - PROCESS | 24389 | RSS: Main: 220073984 20:29:51 INFO - PROCESS | 24389 | 20:29:53 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:53 INFO - PROCESS | 24389 | RSS: Main: 208400384 20:29:53 INFO - PROCESS | 24389 | 20:29:55 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:56 INFO - PROCESS | 24389 | RSS: Main: 210898944 20:29:56 INFO - PROCESS | 24389 | 20:29:58 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:58 INFO - PROCESS | 24389 | RSS: Main: 215785472 20:29:58 INFO - PROCESS | 24389 | 20:30:01 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:01 INFO - PROCESS | 24389 | RSS: Main: 220217344 20:30:01 INFO - PROCESS | 24389 | 20:30:04 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:05 INFO - PROCESS | 24389 | RSS: Main: 220876800 20:30:05 INFO - PROCESS | 24389 | 20:30:06 INFO - PROCESS | 24389 | Cycle 1(1): loaded http://localhost:48211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48211/tests/kraken/driver.html?testName=ai-astar) 20:30:07 INFO - PROCESS | 24389 | RSS: Main: 263180288 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | __start_tp_report 20:30:07 INFO - PROCESS | 24389 | _x_x_mozilla_page_load 20:30:07 INFO - PROCESS | 24389 | _x_x_mozilla_page_load_details 20:30:07 INFO - PROCESS | 24389 | |i|pagename|runs| 20:30:07 INFO - PROCESS | 24389 | |0;ai-astar;110;105;112;111;110;111;112;110;111;112 20:30:07 INFO - PROCESS | 24389 | |1;audio-beat-detection;149;126;130;179;134;127;155;124;159;125 20:30:07 INFO - PROCESS | 24389 | |2;audio-dft;161;161;161;160;161;160;160;162;162;162 20:30:07 INFO - PROCESS | 24389 | |3;audio-fft;74;75;75;126;74;75;75;74;96;76 20:30:07 INFO - PROCESS | 24389 | |4;audio-oscillator;84;83;105;83;83;85;119;84;84;119 20:30:07 INFO - PROCESS | 24389 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;116 20:30:07 INFO - PROCESS | 24389 | |6;imaging-darkroom;145;146;146;145;145;145;145;145;145;145 20:30:07 INFO - PROCESS | 24389 | |7;imaging-desaturate;95;94;94;94;94;94;95;94;95;95 20:30:07 INFO - PROCESS | 24389 | |8;json-parse-financial;54;53;54;53;54;53;53;53;52;57 20:30:07 INFO - PROCESS | 24389 | |9;json-stringify-tinderbox;61;62;61;62;62;62;62;62;64;65 20:30:07 INFO - PROCESS | 24389 | |10;stanford-crypto-aes;83;85;81;78;79;86;79;82;109;79 20:30:07 INFO - PROCESS | 24389 | |11;stanford-crypto-ccm;125;127;118;120;121;119;126;130;126;128 20:30:07 INFO - PROCESS | 24389 | |12;stanford-crypto-pbkdf2;161;168;159;162;167;165;164;162;166;161 20:30:07 INFO - PROCESS | 24389 | |13;stanford-crypto-sha256-iterative;63;66;62;61;64;65;63;61;62;66 20:30:07 INFO - PROCESS | 24389 | __end_tp_report 20:30:07 INFO - PROCESS | 24389 | __start_cc_report 20:30:07 INFO - PROCESS | 24389 | _x_x_mozilla_cycle_collect,1629 20:30:07 INFO - PROCESS | 24389 | __end_cc_report 20:30:07 INFO - PROCESS | 24389 | __startTimestamp1464406207214__endTimestamp 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | ------- Summary: start ------- 20:30:07 INFO - PROCESS | 24389 | Number of tests: 14 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.19 20:30:07 INFO - PROCESS | 24389 | Values: 110.0 105.0 112.0 111.0 110.0 111.0 112.0 110.0 111.0 112.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:141.50 stddev:18.75 (13.2%) stddev-sans-first:19.65 20:30:07 INFO - PROCESS | 24389 | Values: 149.0 126.0 130.0 179.0 134.0 127.0 155.0 124.0 159.0 125.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 20:30:07 INFO - PROCESS | 24389 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 160.0 162.0 162.0 162.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:16.85 (22.5%) stddev-sans-first:17.62 20:30:07 INFO - PROCESS | 24389 | Values: 74.0 75.0 75.0 126.0 74.0 75.0 75.0 74.0 96.0 76.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.50 stddev:15.29 (18.3%) stddev-sans-first:15.87 20:30:07 INFO - PROCESS | 24389 | Values: 84.0 83.0 105.0 83.0 83.0 85.0 119.0 84.0 84.0 119.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:30:07 INFO - PROCESS | 24389 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 20:30:07 INFO - PROCESS | 24389 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:30:07 INFO - PROCESS | 24389 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.35 (2.5%) stddev-sans-first:1.42 20:30:07 INFO - PROCESS | 24389 | Values: 54.0 53.0 54.0 53.0 54.0 53.0 53.0 53.0 52.0 57.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 20:30:07 INFO - PROCESS | 24389 | Values: 61.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 64.0 65.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.50 stddev:9.16 (11.2%) stddev-sans-first:9.71 20:30:07 INFO - PROCESS | 24389 | Values: 83.0 85.0 81.0 78.0 79.0 86.0 79.0 82.0 109.0 79.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.00 stddev:4.16 (3.3%) stddev-sans-first:4.40 20:30:07 INFO - PROCESS | 24389 | Values: 125.0 127.0 118.0 120.0 121.0 119.0 126.0 130.0 126.0 128.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.50 stddev:2.95 (1.8%) stddev-sans-first:2.99 20:30:07 INFO - PROCESS | 24389 | Values: 161.0 168.0 159.0 162.0 167.0 165.0 164.0 162.0 166.0 161.0 20:30:07 INFO - PROCESS | 24389 | 20:30:07 INFO - PROCESS | 24389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.89 (3.0%) stddev-sans-first:2.00 20:30:07 INFO - PROCESS | 24389 | Values: 63.0 66.0 62.0 61.0 64.0 65.0 63.0 61.0 62.0 66.0 20:30:07 INFO - PROCESS | 24389 | -------- Summary: end -------- 20:30:07 INFO - PROCESS | 24389 | 20:30:08 INFO - TEST-INFO | 24389: exit 0 20:30:08 INFO - TEST-OK | kraken | took 60626ms 20:30:08 INFO - SUITE-END | took 1173s 20:30:08 INFO - Completed test suite (00:19:33) 20:30:08 INFO - javascript benchmark 20:30:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.8752049918003, 3123.45339565576, 3155.5739975103356, 3166.6200055993286, 3186.330870517191, 5215.374155101393, 5304.310439642841, 5370.355557333116, 5434.967356202319, 5435.048866448371, 5345.465453454663, 5359.464053594638, 5419.566434685225, 5453.018456677796, 5499.175123731442, 4763.642726795487, 4845.588125009361, 4855.5872750816225, 4860.441049279343, 5047.570956468705, 4927.7536123193695, 4943.406791185045, 4976.203807390818, 4978.77595508203, 5004.62465315101, 4755.239161734124, 4797.808087676489, 4803.231482962727, 4850.6362022848425, 4861.0277944411255, 4839.758012099416, 4843.56407923285, 4849.806007759686, 4851.660383773102, 4854.441739200002, 4787.281907713836, 4808.0383923215495, 4820.542048505386, 4832.178529649933, 4907.362042934431, 5325.8934821303355, 5381.165919282517, 5385.272988146589, 5395.0, 5399.62202645815, 5875.030619947704, 5882.499987501067, 5884.970575147139, 5885.234919460443, 5889.970550147222, 5736.368999410061, 5771.394003629601, 5795.101759227285, 5835.358110607872, 5896.086106653475, 5462.6995515246645, 5499.0, 5501.119820828688, 5503.724813759296, 5505.587080968943, 5727.4845263926445, 6015.3383127855905, 6020.879582408327, 6025.246844144482, 6027.758889644453, 5666.603337766399, 5733.996550603628, 5743.8564035899435, 5746.626469279484, 5750.539956803445, 5819.94180058194, 5866.853328666817, 5875.0, 5875.236219291465, 5878.911816322759, 5623.859403514863, 5754.9424505754405, 5804.361520232771, 5811.389804070596, 5819.243498345188, 5822.3304320003745, 5855.795047173328, 5859.44335288147, 5859.472647461749, 5915.674637894957, 4453.309736990772, 4454.977725111418, 4456.153330867125, 4457.041736026705, 4459.754713490789, 3908.7068469864307, 3913.3934240192816, 3965.0, 3970.4242884781543, 4034.1326614777963, 5491.395946445888, 5515.283013208337, 5518.310211223597, 5519.420460851553, 5520.033994051025, 5895.823125306248, 5895.882082358329, 5898.203742494794, 5903.173555702205, 5940.31686356066, 5343.946560534423, 5449.5640348772, 5501.889962200734, 5506.33923929123, 5553.8333849984565, 5004.699718016931, 5042.697438153723, 5043.621728370314, 5045.596352291808, 5055.646104772631, 5962.463378295887, 6003.609765365325, 6030.668313242726, 6043.909341359883, 6068.423499767515, 5669.688167150846, 5853.239078919713, 5868.94131058684, 5906.26171728534, 5921.259842519685, 5963.612365196248, 6010.9699451502465, 6019.548533860066, 6036.698165091816, 6052.364501727256, 5628.437156284339, 5753.280839895013, 5761.452661997104, 5764.942350576441, 5766.135079738073, 5847.06446968483, 5851.385604511465, 5906.763729450774, 5911.261092363455, 5920.052791553331, 5749.540036796962, 5793.131030345482, 5793.710314484343, 5796.913046304225, 5802.622829516068, 5578.497935185853, 5678.659280443187, 5743.0811070228565, 5751.338596061507, 5755.625884317674, 5631.1271752878365, 5691.630044047124, 5696.11710184922, 5699.829005129853, 5746.913796292975, 5805.448482394166, 5815.273090863642, 5872.647641141545, 5873.823785286449, 5875.294964604275, 5437.564994800327, 5568.220449137205, 5595.748191331319, 5605.383407825055, 5699.971500142473], "value": 5363.718570182423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1689284323419, 615.3354377272544, 631.1038325577679, 639.6737663791466, 645.1033064040987, 30659.540106898385, 31161.376772464566, 42252.788736056355, 42940.0, 43030.139397212035, 41149.17701645965, 45606.0, 45659.0, 45661.77169114158, 45674.31488527675, 8702.65189392425, 8900.421472604292, 8903.0, 8906.153915378029, 8907.376483646147, 8652.307815374756, 8793.428427152214, 8793.824123517526, 8795.340349473783, 8801.427907186044, 8827.691030813923, 8856.335774816882, 8863.734087977371, 8875.68935087272, 8883.022867484571, 8737.432066915662, 8771.254443372321, 8782.64869405223, 8783.780405489882, 8791.340649451253, 8402.45384050041, 8460.746177614681, 8485.151484851527, 8501.06488286288, 8507.106753790888, 42194.0, 42440.0, 42581.57418425838, 42588.36117458241, 42701.0, 3453.7611888198967, 3584.623614520464, 3918.902027449308, 3958.4853968984135, 4120.75275483472, 31940.520892186636, 32034.0, 32431.51352729711, 34074.0, 34189.316213675585, 4215.59951804578, 4263.488381394252, 4268.295731204347, 4291.892702682427, 4407.867763967086, 331559.0, 334426.32786836155, 334627.0, 334720.0, 335851.0, 57549.42450575525, 57703.0, 57709.13436298459, 57845.42154578485, 57989.0, 60989.39010609837, 61205.387946120856, 61385.386146137964, 61443.38556614466, 61460.0, 14180.078294910798, 16162.272697728631, 16327.510174694778, 16548.669026619402, 16566.420175293806, 12370.690732731573, 12496.187747796364, 12502.624921252376, 12503.124781265406, 12503.249805011728, 15422.305996230196, 17100.91449542744, 17122.486325410257, 17175.656486870193, 17214.39749608758, 5680.687562184037, 6410.8076757697345, 6646.60120392778, 6893.896591551131, 6987.6855541499735, 978.3200675530438, 1035.9585616575253, 1067.882532921378, 1110.428129513285, 1117.2291119127776, 32150.517742233886, 32472.188195294835, 32569.0, 32592.674073258964, 33045.339093218485, 1085.5574956348216, 1131.4569006876582, 1171.9920868053466, 1268.0806415348798, 1287.3370214339623, 16238.188090595659, 17113.20830167555, 17347.0, 17781.19984600696, 17823.10884455772, 524886.0, 529352.0, 529777.0, 530315.0, 532480.0, 59110.0, 59178.40821591729, 59302.11046834301, 59332.0, 59411.0, 1330.7538105450524, 1388.4862600837553, 1409.1615488784157, 1410.2135765469952, 1416.2493878244547, 31710.524342135348, 32806.67193328036, 32875.0, 32985.67014329922, 33602.66397336093, 50478.24282635837, 50544.49455505545, 50908.490915091854, 50915.49084509256, 50935.745321273156, 344792.0, 346492.0, 346642.06715866044, 347172.0, 349290.0, 22967.77032229723, 23605.173818916257, 27463.725362746118, 27556.44887102287, 27913.162605121877, 47028.0, 47518.0, 47678.0, 48164.0, 48614.0, 39551.60448395479, 40665.59334406618, 40712.38931415972, 41337.79331103325, 41651.166976660905, 39132.41301380539, 39877.2024559513, 40034.199316012935, 40224.798876005436, 41014.58985410227, 40114.0, 41038.0, 41132.38301425541, 41169.1766164681, 41233.1753364937, 34129.31741365208, 34703.0, 35454.11364715903, 35675.82162089173, 36278.637213627524, 26935.730642694107, 27271.0, 27650.86174569114, 27782.861085694443, 27801.0], "value": 19779.382263420357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.4512392402789, 397.6182864450129, 404.2198556785407, 405.1471652172178, 405.17142443702625, 13860.84448202118, 16890.74663880043, 18517.16672749726, 19206.42380728577, 19206.807931920695, 15112.622184445394, 17728.37950671727, 18408.63182736348, 19047.238110475566, 19387.127579258933, 5590.944090559104, 5765.221695071154, 5767.884642307173, 5768.077107662775, 5793.855153621151, 4210.410542524034, 5631.4087020862835, 5686.0, 6040.66776327304, 6374.936250637481, 6362.618242905417, 6389.393007664265, 6407.839804004914, 6421.389967953037, 6421.743130274784, 6176.629402235858, 6318.304986451487, 6380.7876503464195, 6386.169797926286, 6388.7125079371535, 5456.590755693339, 5589.105743081128, 5595.18869763882, 5624.437556244384, 5639.577031722637, 22166.335009949566, 22752.0, 23033.19383821575, 23053.7694623055, 23173.188938387077, 2326.3951372643064, 2498.7126480454617, 2545.618157276405, 2591.2226332100295, 2599.6230546570832, 14066.437342506288, 14080.788788168185, 14227.573172804832, 14333.78499322511, 14834.629134271621, 1935.129191863667, 2003.2888324644687, 2064.834813214939, 2079.656856618656, 2104.852660313779, 75915.0, 78102.21897781006, 79090.0, 79779.0, 80917.0, 10397.584096636201, 10479.947600262103, 10526.473676316307, 10707.946460267805, 10814.513346899408, 14323.498677546237, 14359.78460323096, 14831.258437078102, 14892.553223403314, 14926.179060151795, 8021.197880212048, 8194.918050819535, 8250.257476827115, 8306.958465207756, 8376.078631350547, 6253.1245625612455, 8006.679732810622, 8024.277814996678, 8136.471129376571, 8202.58987050645, 6018.969905150446, 6333.904991425133, 6359.17330747, 6416.326285740023, 6498.967505162444, 1797.7752780902388, 1843.889366638006, 1861.2275905499337, 1884.4629280655222, 1903.742994695726, 405.40000798817914, 407.97960101995375, 421.1639894808802, 425.3874420834051, 1027.0397178637847, 11427.200095993201, 11899.107566932515, 17495.82504174942, 18708.625827483374, 20304.89847550753, 964.6141543382703, 983.4640121133999, 999.9700008999741, 1000.9949950250348, 1001.4942454060798, 7926.841463170705, 10948.945255273673, 10950.671479855617, 10988.780224395467, 10994.120470362352, 496322.0, 498359.0, 498509.0, 502764.0, 502789.0, 95383.52308238414, 97015.51492242493, 97255.02744972601, 97664.0, 97801.51099244601, 1044.9164066874632, 1050.2753100360726, 1069.5828626835385, 1082.3127314155568, 1083.842842787807, 16861.91569042196, 16989.320427182774, 17170.39903603368, 17257.223424945656, 17513.912430437766, 39210.60789392069, 41241.793791030854, 41307.58692413037, 41765.58234417617, 42074.15851682888, 56636.0, 57445.42554574401, 58515.0, 58522.7073864645, 58987.41012589819, 6772.665261069081, 7557.924420755942, 8518.403711740119, 8601.870971935552, 8910.732678019669, 10905.291156075147, 12210.389480526115, 13327.533536326182, 13327.933360333524, 13419.261940593362, 11730.472128754398, 11800.17398782077, 11888.28670279786, 11952.0, 12133.878661213275, 11393.430328483377, 11587.246828956091, 11763.058955283386, 11928.403579821148, 11932.1050921183, 11785.88214117848, 11947.880521195024, 11955.64133076009, 12154.392280385768, 12304.384780760747, 8682.43564168327, 8735.082816304452, 8767.473951562926, 8835.867461987948, 9061.365704400629, 11968.281903085843, 12011.339376334385, 12103.152779305365, 12131.45408456604, 12196.451159698012], "value": 9189.146735065156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.2109523738131, 1495.8803295736343, 1528.0526073834221, 1667.491415118389, 1796.0, 8429.325653947684, 8843.557822108893, 8861.113888611135, 9096.772580685487, 9099.727008189764, 8860.689875854347, 9046.09539046095, 9051.547422628859, 9057.50183739894, 9062.728118156449, 2075.7301550798375, 2273.533925545259, 2336.5560543496767, 2348.941276468089, 2383.690120284369, 2336.4509340305017, 2338.088145623208, 2341.028473183627, 2341.4146463384154, 2341.555104530142, 2297.2304278066786, 2340.789328960393, 2344.554534638422, 2345.2495201535517, 2346.8005219556358, 2023.9190432382686, 2248.8650680959195, 2310.6302991521443, 2328.0, 2333.265021518216, 2310.976890231093, 2337.135259953828, 2343.355577216279, 2347.6361164019604, 2347.7886990170796, 8858.069902660192, 8918.19736223743, 8927.0, 8959.0, 9010.549472526347, 4990.925136122961, 5137.049645815536, 5138.229265610151, 5142.280080788692, 5144.948550514484, 3436.9656303437146, 3548.3435564420406, 3560.590532088817, 3600.513930619385, 3659.4144936809985, 1184.135581025856, 1200.0759415250209, 1233.407964177191, 1242.0994778785398, 1246.0529997202102, 12755.42600582976, 12776.297303648296, 12777.808332875014, 12797.744045119045, 12797.744045119138, 4735.526447355306, 4785.712857228577, 4870.4155501339355, 4872.0, 4895.069936712013, 9575.760605984906, 9575.952120239494, 9606.519674016272, 9619.903800961902, 9621.951890240503, 4644.071185762861, 5152.793888244503, 5161.922571161435, 5162.045021671003, 5165.811863271469, 4878.731669758197, 4986.4514903360605, 4995.600351971906, 5034.244863270465, 5040.168372218543, 3783.281176576442, 3890.6498415142773, 3905.8047097645003, 3913.7847418391693, 3988.4017397390044, 1132.8130858408435, 1141.7316930521322, 1145.9369734664506, 1153.2676750263474, 1163.30201878872, 986.7434467038622, 991.6182269826169, 993.3890657245742, 1022.3508072374096, 1025.8050970315617, 6065.2418447694035, 6098.969505152535, 6174.876502469925, 6208.565400421927, 6266.968665156736, 432.16376311836694, 432.37521781026743, 437.9562043795595, 443.0474479868309, 443.69385124264153, 4294.184105020036, 4314.245007123741, 4315.158544083936, 4389.100234451929, 4418.0, 10698.144148468104, 11087.279326843729, 11116.777664446827, 11139.721506962229, 11143.498542565603, 10939.726506837393, 11004.614838480615, 11028.779424411627, 11031.613893513688, 11044.226904116635, 7995.0, 8207.179282071864, 8209.0, 8532.658693652309, 8536.402451828437, 6168.876622467616, 6315.463185629273, 6489.7404103835315, 6495.545311828127, 6591.967040164768, 9810.509474526389, 9931.0, 9960.103590676585, 10287.794244115226, 10294.794104118026, 10368.42973636427, 10384.688459346231, 10509.9474502627, 10595.841062384225, 10726.892731072901, 7119.964400177966, 7619.733309334147, 7813.492123011986, 7938.3252423542335, 8149.0, 8842.602082906156, 8846.424982376126, 8869.201771840566, 8913.866292005754, 8929.285657147282, 7639.809004774925, 7724.188960159102, 7770.456068075407, 7868.685252589832, 8100.473469224482, 7753.224677532202, 7941.205879412244, 7998.96000520017, 8049.315808156372, 8142.348612110898, 7162.677679504331, 7331.3768329692575, 7388.0, 7407.444441666788, 7408.073990751156, 5312.734363281743, 5398.1902714593125, 5430.647007944471, 5516.0, 5529.723513824373, 5297.708626025606, 5472.50747432733, 5534.308211473566, 5541.473560011793, 5568.777248909998], "value": 4616.226381046708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.8373580681273, 339.7774457730186, 345.2456382803576, 347.5308333749439, 349.8722966117368, 5358.732063396834, 5367.543758780504, 5376.489233522814, 5390.436773335728, 5408.188771684245, 5323.520883120518, 5349.304590403242, 5365.7585408656605, 5378.677279363241, 5387.138057910725, 4001.8994776436493, 4063.5123785145825, 4145.523264824538, 4170.895727606804, 4180.770057646828, 4134.896627584304, 4155.58444155585, 4156.8129434175535, 4163.854265100722, 4191.658669225849, 3977.925959990801, 4123.958760412403, 4140.544540100586, 4174.478190226222, 4175.603317684815, 4065.817038233272, 4164.646005089571, 4166.91666166675, 4168.478940132483, 4183.3515805049965, 3688.188598508324, 3690.2435000824767, 3710.07248187953, 3715.442683597482, 3716.4611131385795, 5180.352455943007, 5193.221016847466, 5213.817516386908, 5235.73821308933, 5236.162214045735, 4602.355670206174, 4816.7832447539595, 4834.734089625069, 4855.126077306083, 4860.125177468054, 5623.943760562423, 5625.437456254383, 5630.40880707528, 5637.646964728477, 5643.351014633328, 4048.210598933209, 4051.574584668597, 4069.206504731549, 4073.6944729145434, 4085.938710919309, 5582.413846546095, 5865.941340586583, 5872.383399743051, 5877.38456386908, 5893.263342082239, 4018.83924643011, 4020.4170395293104, 4024.6176613221696, 4062.1469491406547, 4070.883140766785, 4104.809605214455, 4135.58644135584, 4137.131202447459, 4183.142455796555, 4194.119234960632, 4683.320918466803, 4688.343631891538, 4726.621870250372, 4752.619790416758, 4756.952430475721, 5597.328320601472, 5607.130894711327, 5617.185508101303, 5647.696097782761, 5669.971650141723, 1403.929803509841, 1415.5894790510843, 1430.4564265579013, 1442.783582462639, 1443.162965480019, 937.8171256604896, 941.4022095968973, 991.4893829677721, 993.4039576254189, 1006.3961623026272, 5453.64551304164, 5472.480114389126, 5481.424450432647, 5489.862753431116, 5491.450854914477, 5851.678157701367, 5881.264841894763, 5899.941000590025, 5913.231279933581, 5917.0, 5368.812091576776, 5388.622796404293, 5409.891802164014, 5433.375161856437, 5441.156620723794, 3069.5702601635344, 3086.058752080592, 3094.7214750672547, 3102.844857757103, 3110.206897241189, 5708.657480551097, 5962.5826192167, 5976.207137858712, 5984.880302393928, 6020.712129390803, 5871.089981052944, 5875.853103672443, 5882.970585147047, 5896.204012458349, 5912.40875912414, 5936.168936348915, 5938.881222375615, 5964.956132676851, 5990.311114221833, 6005.189299444519, 5643.689597072201, 5683.460071293221, 5734.340550836707, 5767.8558036049435, 5780.837796786307, 5666.348369937345, 5722.971385143048, 5731.0, 5741.282339707536, 5751.568632352507, 5694.658320500783, 5883.823485295276, 6002.939970600238, 6031.5476339273855, 6040.848978775566, 4085.121698834646, 4114.938275925803, 4119.361498967545, 4119.887630339732, 4127.823570282455, 5548.9722551388595, 5577.6653400796085, 5761.769529218785, 5777.295697769084, 5873.823785286449, 5650.180723795109, 5668.829935101953, 5685.545156387562, 5687.573431992534, 5711.0, 5621.7189140542, 5629.577781666309, 5648.435156484319, 5662.462066103713, 5665.546756259407, 5355.892882142258, 5624.8875022498505, 5632.746526406239, 5651.406602306699, 5671.808920126819, 5705.258316418839, 5727.799527016535, 5740.885182296247, 5750.338711048283, 5769.0, 5511.972440137773, 5648.830535083954, 5655.660660360391, 5660.490555849993, 5681.971590142188], "value": 4304.161567493549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.9440541959355, 747.6598147842732, 816.3020617372147, 854.1373213054817, 858.4463021351229, 15241.237938103091, 15679.764803527942, 15763.684726305495, 15809.130497822614, 15813.367465301402, 13959.232242226673, 14407.567772966802, 14487.420503179861, 14557.78163327551, 14590.270486475687, 804.388664614894, 809.7570728781371, 820.6676296100089, 821.1460081515218, 822.2763967708408, 814.9388795840335, 817.1256755271861, 818.1123481023097, 818.2799136759672, 818.5088946632033, 850.0819115355432, 850.4982060584254, 850.6257246811414, 850.8723691446271, 851.4550687559966, 842.1704620948361, 843.877637742527, 844.2106630300658, 844.5397258494074, 845.9577021148949, 619.3527763487167, 620.2464006232449, 620.3424370167637, 620.6245221640933, 620.7920346683866, 13635.795463068062, 13686.247256400893, 13693.109947853358, 13995.720085598232, 14658.267086645625, 13576.728465430735, 13773.655658608515, 14315.57053288403, 14446.638834029129, 14841.257937103102, 11325.773484530346, 11727.17909746318, 11772.705682357924, 11829.467673954607, 11847.703807404798, 3773.641504057138, 3777.7166712496673, 3791.810409479515, 3901.8634347797974, 3956.8417263309434, 46784.53215467836, 50684.49315506835, 51999.0, 53499.0, 62641.68679156575, 10787.67636970892, 11160.0, 11351.318920864775, 11360.772784544428, 11751.059915206934, 19930.0, 19989.20043198285, 20000.499987500138, 20031.699524507145, 20040.498987525138, 8541.316694664412, 8657.567121643893, 8916.73249802507, 9118.40730352525, 9142.954285228532, 4721.645876559203, 4830.227163653799, 4846.29728689338, 4895.8041678332465, 5147.7683504242395, 3444.6555344465355, 3537.7700449470703, 3539.3275277697153, 3541.94687079694, 3542.4686297055646, 645.0775391190549, 658.9472842172614, 659.4592434204003, 659.874623821482, 665.627248740697, 610.4140025575408, 661.7882277671099, 746.1493896957472, 761.5392687424139, 795.5187111797279, 9570.99504552026, 9950.950245248727, 9970.302078854556, 10020.849687254697, 10033.698989030341, 583.631384403573, 683.2484267305924, 700.5656492974286, 704.3871831506519, 716.989245161323, 4357.9128417431475, 4632.467266264355, 4650.279206722963, 4659.508957133752, 4689.60138388234, 65493.67253163799, 67148.6642566784, 68727.0, 69001.65499172472, 70816.291837082, 56643.433565663814, 57641.423585764445, 59962.0, 60253.39746602478, 60604.181874543836, 54524.18213726876, 54896.725516372164, 54909.725451373284, 54971.72514137404, 55345.44654553483, 9250.398724082914, 9366.95316523413, 9405.81188376215, 9433.716988490356, 9469.10043545862, 36682.816585917964, 36954.6304536962, 37787.24425511529, 37878.2424351517, 38205.0, 45854.54145458503, 48639.27041094457, 48852.26721599108, 49349.75325123495, 49517.0, 11488.138389620644, 11516.567142622274, 11549.13381496408, 11676.824847627122, 11994.400279986141, 12756.043296752596, 12784.0, 13252.734945300846, 13435.328233588087, 14080.647983800487, 13518.324083795575, 13595.660108497366, 13876.375563099886, 14246.35891384911, 14296.213708246147, 12882.981912660987, 13258.80111798343, 13399.749191868033, 13493.460261589427, 13542.59372218835, 12964.675883102998, 13302.488135189433, 13356.332183390597, 13583.660408489866, 13882.236476993863, 10477.266591338534, 10637.521311541153, 10715.464226788474, 10741.140708743438, 11010.229283950046, 11066.667999960015, 11091.33451992883, 11200.719982000515, 11270.380129092979, 11289.491972861406], "value": 6966.353033487888, "unit": "score"}], "name": "dromaeo_css", "value": 7161.925237612976, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 130.0, 179.0, 134.0, 127.0, 155.0, 124.0, 159.0, 125.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 126.0, 74.0, 75.0, 75.0, 74.0, 96.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 83.0, 83.0, 85.0, 119.0, 84.0, 84.0, 119.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 52.0, 57.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 64.0, 65.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 81.0, 78.0, 79.0, 86.0, 79.0, 82.0, 109.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 118.0, 120.0, 121.0, 119.0, 126.0, 130.0, 126.0, 128.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 168.0, 159.0, 162.0, 167.0, 165.0, 164.0, 162.0, 166.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 61.0, 64.0, 65.0, 63.0, 61.0, 62.0, 66.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1494.1999999999998, "alertThreshold": 2.0}]} 20:30:08 INFO - Return code: 0 20:30:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:30:08 ERROR - # TBPL SUCCESS # 20:30:08 INFO - Running post-action listener: _resource_record_post_action 20:30:08 INFO - ##### 20:30:08 INFO - ##### Finished run-tests step (success) 20:30:08 INFO - ##### 20:30:08 INFO - Running post-run listener: _resource_record_post_run 20:30:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 540291072; Read time: 172; Write time: 386052 20:30:08 INFO - TinderboxPrint: CPU usage
13.1% 20:30:08 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 20:30:08 INFO - TinderboxPrint: I/O write bytes / time
540,291,072 / 386,052 20:30:08 INFO - TinderboxPrint: CPU idle
8,267.5 (86.9%) 20:30:08 INFO - TinderboxPrint: CPU user
1,204.2 (12.7%) 20:30:08 INFO - TinderboxPrint: Swap in / out
0 / 0 20:30:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247156736; Read time: 0; Write time: 196052 20:30:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293134336; Read time: 172; Write time: 190000 20:30:09 INFO - Running post-run listener: _upload_blobber_files 20:30:09 INFO - Blob upload gear active. 20:30:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:30:09 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 20:30:09 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'] 20:30:09 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 20:30:09 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:10 INFO - (blobuploader) - INFO - Done attempting. 20:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:11 INFO - (blobuploader) - INFO - Done attempting. 20:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:15 INFO - (blobuploader) - INFO - Done attempting. 20:30:15 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:15 INFO - Return code: 0 20:30:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:30:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fa557eb6f21d7979194802d524eebf1b348d6153470c9ade96f4e0e82f86670f9da0894cb230aeb349b2efe46f0c1919d92cb58f58e069d97974794ddcf1404", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020e30d63cf6d1a42810282159b4b768671bc80382571aff078282a2d51a2b095e98ab0463233ac2558b9888aa38b6a5baddf5c97bafac82dc5940d4b22eb930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5492bbcf37e65bb07dba1fa357b9fc43365370a66188ca6b7f1e07abd1081a7b1c36e96737991519ea9baa78b492df73f0e2796f7024ff8f3ab71709233bc255"} 20:30:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:30:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:30:15 INFO - Contents: 20:30:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fa557eb6f21d7979194802d524eebf1b348d6153470c9ade96f4e0e82f86670f9da0894cb230aeb349b2efe46f0c1919d92cb58f58e069d97974794ddcf1404", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020e30d63cf6d1a42810282159b4b768671bc80382571aff078282a2d51a2b095e98ab0463233ac2558b9888aa38b6a5baddf5c97bafac82dc5940d4b22eb930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5492bbcf37e65bb07dba1fa357b9fc43365370a66188ca6b7f1e07abd1081a7b1c36e96737991519ea9baa78b492df73f0e2796f7024ff8f3ab71709233bc255"} 20:30:15 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:15 INFO - Copying logs to upload dir... 20:30:15 INFO - mkdir: /builds/slave/test/build/upload/logs 20:30:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.895364 ========= master_lag: 8.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-27 20:30:23.342092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 20:30:23.345889) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 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/1fa557eb6f21d7979194802d524eebf1b348d6153470c9ade96f4e0e82f86670f9da0894cb230aeb349b2efe46f0c1919d92cb58f58e069d97974794ddcf1404", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020e30d63cf6d1a42810282159b4b768671bc80382571aff078282a2d51a2b095e98ab0463233ac2558b9888aa38b6a5baddf5c97bafac82dc5940d4b22eb930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5492bbcf37e65bb07dba1fa357b9fc43365370a66188ca6b7f1e07abd1081a7b1c36e96737991519ea9baa78b492df73f0e2796f7024ff8f3ab71709233bc255"} build_url:https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/Zh93r8H-Qbmo7bUl0O0TrA/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/1fa557eb6f21d7979194802d524eebf1b348d6153470c9ade96f4e0e82f86670f9da0894cb230aeb349b2efe46f0c1919d92cb58f58e069d97974794ddcf1404", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/020e30d63cf6d1a42810282159b4b768671bc80382571aff078282a2d51a2b095e98ab0463233ac2558b9888aa38b6a5baddf5c97bafac82dc5940d4b22eb930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5492bbcf37e65bb07dba1fa357b9fc43365370a66188ca6b7f1e07abd1081a7b1c36e96737991519ea9baa78b492df73f0e2796f7024ff8f3ab71709233bc255"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 20:30:23.377298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:30:23.377684) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464403844.87668-1706807092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 20:30:23.431824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 20:30:23.432184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 20:30:23.432515) ========= ========= Total master_lag: 8.40 =========