builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1463184992.88 results: success (0) buildid: 20160513143238 builduid: 3e53ef6374ea4438b40c6e62af43b9ac revision: edcd8d596806c757423acc2573c9047c569fb4f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:32.881866) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:32.882278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:32.882578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:32.939614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:32.939871) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 17:16: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% 21.8M=0.001s 2016-05-13 17:16:33 (21.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:33.078246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:33.078552) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:33.129132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:33.129526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev edcd8d596806c757423acc2573c9047c569fb4f8 --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 edcd8d596806c757423acc2573c9047c569fb4f8 --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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 17:16:33,805 truncating revision to first 12 chars 2016-05-13 17:16:33,805 Setting DEBUG logging. 2016-05-13 17:16:33,805 attempt 1/10 2016-05-13 17:16:33,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/edcd8d596806?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 17:16:34,489 unpacking tar archive at: fx-team-edcd8d596806/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:34.085911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:34.086183) ========= script_repo_revision: edcd8d596806c757423acc2573c9047c569fb4f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:34.086564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:34.086824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 17:16:34.093935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-13 17:16:34.094235) ========= /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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:16:34 INFO - MultiFileLogger online at 20160513 17:16:34 in /builds/slave/test 17:16:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:34 INFO - {'append_to_log': False, 17:16:34 INFO - 'base_work_dir': '/builds/slave/test', 17:16:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:34 INFO - 'branch': 'Fx-Team', 17:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:34 INFO - 'config_files': ('talos/linux_config.py',), 17:16:34 INFO - 'default_actions': ('clobber', 17:16:34 INFO - 'read-buildbot-config', 17:16:34 INFO - 'download-and-extract', 17:16:34 INFO - 'populate-webroot', 17:16:34 INFO - 'create-virtualenv', 17:16:34 INFO - 'install', 17:16:34 INFO - 'run-tests'), 17:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:34 INFO - 'download_minidump_stackwalk': True, 17:16:34 INFO - 'download_symbols': 'ondemand', 17:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:34 INFO - 'installer_path': 'installer.exe', 17:16:34 INFO - 'log_level': 'info', 17:16:34 INFO - 'log_name': 'talos', 17:16:34 INFO - 'log_to_console': True, 17:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:16:34 INFO - 'opt_config_files': (), 17:16:34 INFO - 'pip_index': False, 17:16:34 INFO - 'sps_profile': False, 17:16:34 INFO - 'sps_profile_interval': 0, 17:16:34 INFO - 'suite': 'dromaeojs', 17:16:34 INFO - 'system_bits': '32', 17:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:34 INFO - 'title': 'talos-linux64-ix-059', 17:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:34 INFO - 'use_talos_json': True, 17:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:34 INFO - 'work_dir': 'build'} 17:16:34 INFO - ##### 17:16:34 INFO - ##### Running clobber step. 17:16:34 INFO - ##### 17:16:34 INFO - Running pre-action listener: _resource_record_pre_action 17:16:34 INFO - Running main action method: clobber 17:16:34 INFO - rmtree: /builds/slave/test/build 17:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:35 INFO - Running post-action listener: _resource_record_post_action 17:16:35 INFO - ##### 17:16:35 INFO - ##### Finished clobber step (success) 17:16:35 INFO - ##### 17:16:35 INFO - ##### 17:16:35 INFO - ##### Running read-buildbot-config step. 17:16:35 INFO - ##### 17:16:35 INFO - Running pre-action listener: _resource_record_pre_action 17:16:35 INFO - Running main action method: read_buildbot_config 17:16:35 INFO - Using buildbot properties: 17:16:35 INFO - { 17:16:35 INFO - "project": "", 17:16:35 INFO - "product": "firefox", 17:16:35 INFO - "script_repo_revision": "production", 17:16:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:16:35 INFO - "repository": "", 17:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:16:35 INFO - "buildid": "20160513143238", 17:16:35 INFO - "pgo_build": "True", 17:16:35 INFO - "basedir": "/builds/slave/test", 17:16:35 INFO - "buildnumber": 676, 17:16:35 INFO - "slavename": "talos-linux64-ix-059", 17:16:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:16:35 INFO - "platform": "ubuntu64_hw", 17:16:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:16:35 INFO - "branch": "fx-team", 17:16:35 INFO - "repo_path": "integration/fx-team", 17:16:35 INFO - "revision": "edcd8d596806c757423acc2573c9047c569fb4f8", 17:16:35 INFO - "stage_platform": "linux64-pgo", 17:16:35 INFO - "builduid": "3e53ef6374ea4438b40c6e62af43b9ac", 17:16:35 INFO - "slavebuilddir": "test" 17:16:35 INFO - } 17:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:16:35 INFO - Running post-action listener: _resource_record_post_action 17:16:35 INFO - ##### 17:16:35 INFO - ##### Finished read-buildbot-config step (success) 17:16:35 INFO - ##### 17:16:35 INFO - ##### 17:16:35 INFO - ##### Running download-and-extract step. 17:16:35 INFO - ##### 17:16:35 INFO - Running pre-action listener: _resource_record_pre_action 17:16:35 INFO - Running main action method: download_and_extract 17:16:35 INFO - mkdir: /builds/slave/test/build/tests 17:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:35 INFO - https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:43 INFO - Downloaded 1361 bytes. 17:16:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:43 INFO - Using the following test package requirements: 17:16:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:16:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:16:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'jsshell-linux-x86_64.zip'], 17:16:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:16:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:16:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:16:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:16:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:16:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:43 INFO - https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:54 INFO - Downloaded 23909469 bytes. 17:16:54 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'] 17:16:54 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 17:16:55 INFO - Return code: 0 17:16:55 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 17:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:55 INFO - https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:57 INFO - Downloaded 23909469 bytes. 17:16:57 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'] 17:16:57 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 17:16:59 INFO - Return code: 0 17:16: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')]} 17:16:59 INFO - https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:17:00 INFO - Downloaded 10840239 bytes. 17:17:00 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'] 17:17:00 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 17:17:01 INFO - Return code: 0 17:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:01 INFO - https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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 17:17:02 INFO - Downloaded 58396259 bytes. 17:17:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:02 INFO - mkdir: /builds/slave/test/properties 17:17:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:02 INFO - Contents: 17:17:02 INFO - build_url:https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:03 INFO - Running post-action listener: _resource_record_post_action 17:17:03 INFO - Running post-action listener: set_extra_try_arguments 17:17:03 INFO - ##### 17:17:03 INFO - ##### Finished download-and-extract step (success) 17:17:03 INFO - ##### 17:17:03 INFO - ##### 17:17:03 INFO - ##### Running populate-webroot step. 17:17:03 INFO - ##### 17:17:03 INFO - Running pre-action listener: _resource_record_pre_action 17:17:03 INFO - Running main action method: populate_webroot 17:17:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:03 INFO - '--tppagecycles', 17:17:03 INFO - '7'], 17:17:03 INFO - 'tests': ['tsvgm']}}, 17:17:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['damp', 'tps']}, 17:17:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'tests': ['damp', 'tps']}, 17:17:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['dromaeo_dom']}, 17:17:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['a11yr', 17:17:03 INFO - 'ts_paint', 17:17:03 INFO - 'tpaint', 17:17:03 INFO - 'sessionrestore', 17:17:03 INFO - 'sessionrestore_no_auto_restore', 17:17:03 INFO - 'tabpaint']}, 17:17:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['tsvgx', 17:17:03 INFO - 'tsvgr_opacity', 17:17:03 INFO - 'tart', 17:17:03 INFO - 'tscrollx', 17:17:03 INFO - 'cart']}, 17:17:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:03 INFO - 'tsvgr_opacity', 17:17:03 INFO - 'tart', 17:17:03 INFO - 'tscrollx', 17:17:03 INFO - 'cart']}, 17:17:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'talos_options': ['--disable-e10s'], 17:17:03 INFO - 'tests': ['tp5o']}, 17:17:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'tests': ['tp5o']}, 17:17:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'talos_options': ['--disable-e10s', 17:17:03 INFO - '--xperf_path', 17:17:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:03 INFO - 'tests': ['tp5n']}, 17:17:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:03 INFO - 'talos_options': ['--xperf_path', 17:17:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:03 INFO - 'tests': ['tp5n']}}, 17:17:03 INFO - 'talos.zip': {'path': '', 17:17:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:03 INFO - Running post-action listener: _resource_record_post_action 17:17:03 INFO - ##### 17:17:03 INFO - ##### Finished populate-webroot step (success) 17:17:03 INFO - ##### 17:17:03 INFO - ##### 17:17:03 INFO - ##### Running create-virtualenv step. 17:17:03 INFO - ##### 17:17:03 INFO - Running pre-action listener: _resource_record_pre_action 17:17:03 INFO - Running main action method: create_virtualenv 17:17:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:03 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 17:17:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:03 INFO - Using real prefix '/usr' 17:17:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:03 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:05 INFO - Installing pip.................done. 17:17:05 INFO - Return code: 0 17:17:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:05 INFO - Using env: {'DISPLAY': ':0', 17:17:05 INFO - 'HOME': '/home/cltbld', 17:17:05 INFO - 'LANG': 'en_US.UTF-8', 17:17:05 INFO - 'LANGUAGE': 'en_US:en', 17:17:05 INFO - 'LOGNAME': 'cltbld', 17:17:05 INFO - 'MAIL': '/var/mail/cltbld', 17:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:05 INFO - 'MOZ_NO_REMOTE': '1', 17:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:05 INFO - 'NO_EM_RESTART': '1', 17:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:05 INFO - 'PWD': '/builds/slave/test', 17:17:05 INFO - 'SHELL': '/bin/bash', 17:17:05 INFO - 'SHLVL': '1', 17:17:05 INFO - 'TERM': 'linux', 17:17:05 INFO - 'TMOUT': '86400', 17:17:05 INFO - 'USER': 'cltbld', 17:17:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:05 INFO - '_': '/tools/buildbot/bin/python'} 17:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:06 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 17:17:06 INFO - Cleaning up... 17:17:06 INFO - Return code: 0 17:17:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:06 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:06 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 17:17:06 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 17:17:06 INFO - Using env: {'DISPLAY': ':0', 17:17:06 INFO - 'HOME': '/home/cltbld', 17:17:06 INFO - 'LANG': 'en_US.UTF-8', 17:17:06 INFO - 'LANGUAGE': 'en_US:en', 17:17:06 INFO - 'LOGNAME': 'cltbld', 17:17:06 INFO - 'MAIL': '/var/mail/cltbld', 17:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:06 INFO - 'MOZ_NO_REMOTE': '1', 17:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:06 INFO - 'NO_EM_RESTART': '1', 17:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:06 INFO - 'PWD': '/builds/slave/test', 17:17:06 INFO - 'SHELL': '/bin/bash', 17:17:06 INFO - 'SHLVL': '1', 17:17:06 INFO - 'TERM': 'linux', 17:17:06 INFO - 'TMOUT': '86400', 17:17:06 INFO - 'USER': 'cltbld', 17:17:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:06 INFO - '_': '/tools/buildbot/bin/python'} 17:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:06 INFO - Downloading/unpacking psutil>=3.1.1 17:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:08 INFO - Installing collected packages: psutil 17:17:08 INFO - Running setup.py install for psutil 17:17:08 INFO - building 'psutil._psutil_linux' extension 17:17:08 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 17:17:08 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 17:17:08 INFO - building 'psutil._psutil_posix' extension 17:17:08 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 17:17:08 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 17:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:08 INFO - Successfully installed psutil 17:17:08 INFO - Cleaning up... 17:17:08 INFO - Return code: 0 17:17:08 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 17:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 17:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 17:17:08 INFO - Using env: {'DISPLAY': ':0', 17:17:08 INFO - 'HOME': '/home/cltbld', 17:17:08 INFO - 'LANG': 'en_US.UTF-8', 17:17:08 INFO - 'LANGUAGE': 'en_US:en', 17:17:08 INFO - 'LOGNAME': 'cltbld', 17:17:08 INFO - 'MAIL': '/var/mail/cltbld', 17:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:08 INFO - 'MOZ_NO_REMOTE': '1', 17:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:08 INFO - 'NO_EM_RESTART': '1', 17:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:08 INFO - 'PWD': '/builds/slave/test', 17:17:08 INFO - 'SHELL': '/bin/bash', 17:17:08 INFO - 'SHLVL': '1', 17:17:08 INFO - 'TERM': 'linux', 17:17:08 INFO - 'TMOUT': '86400', 17:17:08 INFO - 'USER': 'cltbld', 17:17:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:08 INFO - '_': '/tools/buildbot/bin/python'} 17:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:09 INFO - Downloading/unpacking mozsystemmonitor==0.1 17:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:10 INFO - Downloading mozsystemmonitor-0.1.tar.gz 17:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 17:17:11 INFO - Installing collected packages: mozsystemmonitor 17:17:11 INFO - Running setup.py install for mozsystemmonitor 17:17:11 INFO - Successfully installed mozsystemmonitor 17:17:11 INFO - Cleaning up... 17:17:11 INFO - Return code: 0 17:17:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:11 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:11 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 17:17:11 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 17:17:11 INFO - Using env: {'DISPLAY': ':0', 17:17:11 INFO - 'HOME': '/home/cltbld', 17:17:11 INFO - 'LANG': 'en_US.UTF-8', 17:17:11 INFO - 'LANGUAGE': 'en_US:en', 17:17:11 INFO - 'LOGNAME': 'cltbld', 17:17:11 INFO - 'MAIL': '/var/mail/cltbld', 17:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:11 INFO - 'MOZ_NO_REMOTE': '1', 17:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:11 INFO - 'NO_EM_RESTART': '1', 17:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:11 INFO - 'PWD': '/builds/slave/test', 17:17:11 INFO - 'SHELL': '/bin/bash', 17:17:11 INFO - 'SHLVL': '1', 17:17:11 INFO - 'TERM': 'linux', 17:17:11 INFO - 'TMOUT': '86400', 17:17:11 INFO - 'USER': 'cltbld', 17:17:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:11 INFO - '_': '/tools/buildbot/bin/python'} 17:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:13 INFO - Downloading docopt-0.6.1.tar.gz 17:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:14 INFO - Running setup.py install for blobuploader 17:17:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:14 INFO - Running setup.py install for requests 17:17:14 INFO - Running setup.py install for docopt 17:17:14 INFO - Successfully installed blobuploader requests docopt 17:17:14 INFO - Cleaning up... 17:17:14 INFO - Return code: 0 17:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:14 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')]} 17:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:14 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')]} 17:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:14 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:14 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 17:17:14 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 17:17:14 INFO - Using env: {'DISPLAY': ':0', 17:17:14 INFO - 'HOME': '/home/cltbld', 17:17:14 INFO - 'LANG': 'en_US.UTF-8', 17:17:14 INFO - 'LANGUAGE': 'en_US:en', 17:17:14 INFO - 'LOGNAME': 'cltbld', 17:17:14 INFO - 'MAIL': '/var/mail/cltbld', 17:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:14 INFO - 'MOZ_NO_REMOTE': '1', 17:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:14 INFO - 'NO_EM_RESTART': '1', 17:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:14 INFO - 'PWD': '/builds/slave/test', 17:17:14 INFO - 'SHELL': '/bin/bash', 17:17:14 INFO - 'SHLVL': '1', 17:17:14 INFO - 'TERM': 'linux', 17:17:14 INFO - 'TMOUT': '86400', 17:17:14 INFO - 'USER': 'cltbld', 17:17:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:14 INFO - '_': '/tools/buildbot/bin/python'} 17:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:14 INFO - Running setup.py (path:/tmp/pip-ziBqcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:14 INFO - Running setup.py (path:/tmp/pip-9Ycz2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:14 INFO - Running setup.py (path:/tmp/pip-7JmGHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:15 INFO - Running setup.py (path:/tmp/pip-DBmyMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:15 INFO - Running setup.py (path:/tmp/pip-rala9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:15 INFO - Running setup.py (path:/tmp/pip-Dbwd8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:15 INFO - Running setup.py (path:/tmp/pip-BmAsAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:15 INFO - Running setup.py (path:/tmp/pip-DA_PQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:15 INFO - Running setup.py (path:/tmp/pip-dLE0vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:15 INFO - Running setup.py (path:/tmp/pip-1WcRQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:15 INFO - Running setup.py (path:/tmp/pip-6SFodv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:15 INFO - Running setup.py (path:/tmp/pip-7O4Nfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:15 INFO - Running setup.py (path:/tmp/pip-J53neO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:15 INFO - Running setup.py (path:/tmp/pip-wUafkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:15 INFO - Running setup.py (path:/tmp/pip-ureIUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:15 INFO - Running setup.py (path:/tmp/pip-qrcRBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:15 INFO - Running setup.py (path:/tmp/pip-4S8Xhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:16 INFO - Running setup.py install for manifestparser 17:17:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozcrash 17:17:16 INFO - Running setup.py install for mozdebug 17:17:16 INFO - Running setup.py install for mozdevice 17:17:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozfile 17:17:16 INFO - Running setup.py install for mozhttpd 17:17:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozinfo 17:17:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozInstall 17:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozleak 17:17:16 INFO - Running setup.py install for mozlog 17:17:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for moznetwork 17:17:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozprocess 17:17:17 INFO - Running setup.py install for mozprofile 17:17:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozrunner 17:17:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozscreenshot 17:17:17 INFO - Running setup.py install for moztest 17:17:17 INFO - Running setup.py install for mozversion 17:17:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:17 INFO - Cleaning up... 17:17:17 INFO - Return code: 0 17:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:17 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:17 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 17:17:17 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 17:17:17 INFO - Using env: {'DISPLAY': ':0', 17:17:17 INFO - 'HOME': '/home/cltbld', 17:17:17 INFO - 'LANG': 'en_US.UTF-8', 17:17:17 INFO - 'LANGUAGE': 'en_US:en', 17:17:17 INFO - 'LOGNAME': 'cltbld', 17:17:17 INFO - 'MAIL': '/var/mail/cltbld', 17:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:17 INFO - 'MOZ_NO_REMOTE': '1', 17:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:17 INFO - 'NO_EM_RESTART': '1', 17:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:17 INFO - 'PWD': '/builds/slave/test', 17:17:17 INFO - 'SHELL': '/bin/bash', 17:17:17 INFO - 'SHLVL': '1', 17:17:17 INFO - 'TERM': 'linux', 17:17:17 INFO - 'TMOUT': '86400', 17:17:17 INFO - 'USER': 'cltbld', 17:17:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:17 INFO - '_': '/tools/buildbot/bin/python'} 17:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 INFO - Running setup.py (path:/tmp/pip-aepBnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 INFO - Running setup.py (path:/tmp/pip-Ux1L4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 INFO - Running setup.py (path:/tmp/pip-kacLxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:18 INFO - Running setup.py (path:/tmp/pip-2JP7D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:18 INFO - Running setup.py (path:/tmp/pip-eOD9GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:18 INFO - Running setup.py (path:/tmp/pip-5BuPtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:18 INFO - Running setup.py (path:/tmp/pip-MujPan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:18 INFO - Running setup.py (path:/tmp/pip-OGQRVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:18 INFO - Running setup.py (path:/tmp/pip-Fh4yZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:18 INFO - Running setup.py (path:/tmp/pip-VzHj4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:18 INFO - Running setup.py (path:/tmp/pip-G_Hc0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:18 INFO - Running setup.py (path:/tmp/pip-Ze8VAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:18 INFO - Running setup.py (path:/tmp/pip-5yxQv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:19 INFO - Running setup.py (path:/tmp/pip-Qw9UG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:19 INFO - Running setup.py (path:/tmp/pip-NAuNZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:19 INFO - Running setup.py (path:/tmp/pip-lcK8KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:19 INFO - Running setup.py (path:/tmp/pip-i6M_EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:19 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)) 17:17:19 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)) 17:17:19 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)) 17:17:19 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)) 17:17:19 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)) 17:17:19 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)) 17:17:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:21 INFO - Downloading blessings-1.6.tar.gz 17:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:21 INFO - Installing collected packages: blessings 17:17:21 INFO - Running setup.py install for blessings 17:17:21 INFO - Successfully installed blessings 17:17:21 INFO - Cleaning up... 17:17:21 INFO - Return code: 0 17:17:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:21 INFO - Reading from file tmpfile_stdout 17:17:21 INFO - Current package versions: 17:17:21 INFO - argparse == 1.2.1 17:17:21 INFO - blessings == 1.6 17:17:21 INFO - blobuploader == 1.2.4 17:17:21 INFO - docopt == 0.6.1 17:17:21 INFO - manifestparser == 1.1 17:17:21 INFO - mozInstall == 1.12 17:17:21 INFO - mozcrash == 0.17 17:17:21 INFO - mozdebug == 0.1 17:17:21 INFO - mozdevice == 0.48 17:17:21 INFO - mozfile == 1.2 17:17:21 INFO - mozhttpd == 0.7 17:17:21 INFO - mozinfo == 0.9 17:17:21 INFO - mozleak == 0.1 17:17:21 INFO - mozlog == 3.2 17:17:21 INFO - moznetwork == 0.27 17:17:21 INFO - mozprocess == 0.22 17:17:21 INFO - mozprofile == 0.28 17:17:21 INFO - mozrunner == 6.11 17:17:21 INFO - mozscreenshot == 0.1 17:17:21 INFO - mozsystemmonitor == 0.1 17:17:21 INFO - moztest == 0.7 17:17:21 INFO - mozversion == 1.4 17:17:21 INFO - psutil == 3.1.1 17:17:21 INFO - requests == 1.2.3 17:17:21 INFO - wsgiref == 0.1.2 17:17:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:21 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')]} 17:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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')]} 17:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:21 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 17:17:21 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 17:17:21 INFO - Using env: {'DISPLAY': ':0', 17:17:21 INFO - 'HOME': '/home/cltbld', 17:17:21 INFO - 'LANG': 'en_US.UTF-8', 17:17:21 INFO - 'LANGUAGE': 'en_US:en', 17:17:21 INFO - 'LOGNAME': 'cltbld', 17:17:21 INFO - 'MAIL': '/var/mail/cltbld', 17:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:21 INFO - 'MOZ_NO_REMOTE': '1', 17:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:21 INFO - 'NO_EM_RESTART': '1', 17:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:21 INFO - 'PWD': '/builds/slave/test', 17:17:21 INFO - 'SHELL': '/bin/bash', 17:17:21 INFO - 'SHLVL': '1', 17:17:21 INFO - 'TERM': 'linux', 17:17:21 INFO - 'TMOUT': '86400', 17:17:21 INFO - 'USER': 'cltbld', 17:17:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:21 INFO - '_': '/tools/buildbot/bin/python'} 17:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 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)) 17:17:21 INFO - Cleaning up... 17:17:21 INFO - Return code: 0 17:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:21 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')]} 17:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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')]} 17:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:21 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 17:17:21 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 17:17:21 INFO - Using env: {'DISPLAY': ':0', 17:17:21 INFO - 'HOME': '/home/cltbld', 17:17:21 INFO - 'LANG': 'en_US.UTF-8', 17:17:21 INFO - 'LANGUAGE': 'en_US:en', 17:17:21 INFO - 'LOGNAME': 'cltbld', 17:17:21 INFO - 'MAIL': '/var/mail/cltbld', 17:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:21 INFO - 'MOZ_NO_REMOTE': '1', 17:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:21 INFO - 'NO_EM_RESTART': '1', 17:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:21 INFO - 'PWD': '/builds/slave/test', 17:17:21 INFO - 'SHELL': '/bin/bash', 17:17:21 INFO - 'SHLVL': '1', 17:17:21 INFO - 'TERM': 'linux', 17:17:21 INFO - 'TMOUT': '86400', 17:17:21 INFO - 'USER': 'cltbld', 17:17:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:21 INFO - '_': '/tools/buildbot/bin/python'} 17:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:22 INFO - Downloading/unpacking jsonschema 17:17:22 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 17:17:22 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 17:17:22 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 17:17:22 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 17:17:22 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 17:17:22 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 17:17:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:23 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17:23 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 17:17:23 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 17:17:23 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 17:17:23 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 17:17:23 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 17:17:23 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 17:17:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:24 INFO - warning: no files found matching '*.txt' 17:17:24 INFO - no previously-included directories found matching 'build' 17:17:24 INFO - no previously-included directories found matching 'dist' 17:17:24 INFO - no previously-included directories found matching '.git*' 17:17:24 INFO - Installing collected packages: jsonschema, functools32 17:17:24 INFO - Running setup.py install for functools32 17:17:24 INFO - warning: no files found matching '*.txt' 17:17:24 INFO - no previously-included directories found matching 'build' 17:17:24 INFO - no previously-included directories found matching 'dist' 17:17:24 INFO - no previously-included directories found matching '.git*' 17:17:24 INFO - Successfully installed jsonschema functools32 17:17:24 INFO - Cleaning up... 17:17:24 INFO - Return code: 0 17:17:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17:24 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')]} 17:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 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')]} 17:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 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 0x7f96c7ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1254770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', '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 17:17:24 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 17:17:24 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 17:17:24 INFO - Using env: {'DISPLAY': ':0', 17:17:24 INFO - 'HOME': '/home/cltbld', 17:17:24 INFO - 'LANG': 'en_US.UTF-8', 17:17:24 INFO - 'LANGUAGE': 'en_US:en', 17:17:24 INFO - 'LOGNAME': 'cltbld', 17:17:24 INFO - 'MAIL': '/var/mail/cltbld', 17:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:24 INFO - 'MOZ_NO_REMOTE': '1', 17:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:24 INFO - 'NO_EM_RESTART': '1', 17:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:24 INFO - 'PWD': '/builds/slave/test', 17:17:24 INFO - 'SHELL': '/bin/bash', 17:17:24 INFO - 'SHLVL': '1', 17:17:24 INFO - 'TERM': 'linux', 17:17:24 INFO - 'TMOUT': '86400', 17:17:24 INFO - 'USER': 'cltbld', 17:17:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:24 INFO - '_': '/tools/buildbot/bin/python'} 17:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:24 INFO - Downloading/unpacking flake8 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:27 INFO - no previously-included directories found matching 'docs/_build' 17:17:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:27 INFO - Running setup.py install for pep8 17:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:27 INFO - no previously-included directories found matching 'docs/_build' 17:17:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:27 INFO - Cleaning up... 17:17:27 INFO - Return code: 0 17:17:27 INFO - Running post-action listener: _resource_record_post_action 17:17:27 INFO - Running post-action listener: _start_resource_monitoring 17:17:27 INFO - Starting resource monitoring. 17:17:27 INFO - ##### 17:17:27 INFO - ##### Finished create-virtualenv step (success) 17:17:27 INFO - ##### 17:17:27 INFO - ##### 17:17:27 INFO - ##### Running install step. 17:17:27 INFO - ##### 17:17:27 INFO - Running pre-action listener: _resource_record_pre_action 17:17:27 INFO - Running main action method: install 17:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:27 INFO - Reading from file tmpfile_stdout 17:17:27 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:27 INFO - Reading from file tmpfile_stdout 17:17:27 INFO - Output received: 17:17:27 INFO - Usage: mozinstall [options] installer 17:17:27 INFO - Options: 17:17:27 INFO - -h, --help show this help message and exit 17:17:27 INFO - -d DEST, --destination=DEST 17:17:27 INFO - Directory to install application into. [default: 17:17:27 INFO - "/builds/slave/test"] 17:17:27 INFO - --app=APP Application being installed. [default: firefox] 17:17:27 INFO - mkdir: /builds/slave/test/build/application 17:17:27 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'] 17:17:27 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 17:17:44 INFO - Reading from file tmpfile_stdout 17:17:44 INFO - Output received: 17:17:44 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:44 INFO - Running post-action listener: _resource_record_post_action 17:17:44 INFO - ##### 17:17:44 INFO - ##### Finished install step (success) 17:17:44 INFO - ##### 17:17:44 INFO - ##### 17:17:44 INFO - ##### Running run-tests step. 17:17:44 INFO - ##### 17:17:44 INFO - Running pre-action listener: _resource_record_pre_action 17:17:44 INFO - Running main action method: run_tests 17:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:44 INFO - Python 2.7.3 17:17:44 INFO - Return code: 0 17:17:44 INFO - grabbing minidump binary from tooltool 17:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:44 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 0x12e39c0>, '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 0x12e48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:44 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 17:17:44 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 17:17:44 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 17:17:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:44 INFO - Return code: 0 17:17:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:17:45 INFO - Return code: 0 17:17:45 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/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 17:17:45 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/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test', 17:17:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:45 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/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 17:17:45 INFO - mozversion application_buildid: 20160513143238 17:17:45 INFO - mozversion application_changeset: edcd8d596806c757423acc2573c9047c569fb4f8 17:17:45 INFO - mozversion application_display_name: Nightly 17:17:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:45 INFO - mozversion application_name: Firefox 17:17:45 INFO - mozversion application_remotingname: firefox 17:17:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:17:45 INFO - mozversion application_vendor: Mozilla 17:17:45 INFO - mozversion application_version: 49.0a1 17:17:45 INFO - mozversion platform_buildid: 20160513143238 17:17:45 INFO - mozversion platform_changeset: edcd8d596806c757423acc2573c9047c569fb4f8 17:17:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:17:45 INFO - mozversion platform_version: 49.0a1 17:17:45 INFO - using testdate: 1463185065 17:17:45 INFO - actual date: 1463185065 17:17:45 INFO - starting webserver on 'localhost:39298' 17:17:45 INFO - SUITE-START | Running 2 tests 17:17:45 INFO - TEST-START | dromaeo_css 17:17:45 INFO - operating with platform_type : linux_ 17:17:45 INFO - Initialising browser for dromaeo_css test... 17:17:45 INFO - TEST-INFO | started process 32572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksoSNe/profile http://localhost:39298/getInfo.html) 17:17:49 INFO - PROCESS | 32572 | __metrics Screen width/height:1600/1200 17:17:49 INFO - PROCESS | 32572 | colorDepth:24 17:17:49 INFO - PROCESS | 32572 | Browser inner width/height: 1024/697 17:17:49 INFO - PROCESS | 32572 | __metrics 17:17:50 ERROR - PROCESS | 32572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:17:51 INFO - TEST-INFO | 32572: exit 0 17:17:51 INFO - Browser initialized. 17:17:51 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:51 INFO - TEST-INFO | started process 32655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksoSNe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:02 INFO - PROCESS | 32655 | RSS: Main: 152289280 17:18:02 INFO - PROCESS | 32655 | 17:18:53 INFO - PROCESS | 32655 | 1463185133799 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] 17:21:02 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39298/tests/dromaeo/cssquery-ext.html) 17:21:03 INFO - PROCESS | 32655 | RSS: Main: 260464640 17:21:03 INFO - PROCESS | 32655 | 17:24:05 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-ext.html (next: http://localhost:39298/tests/dromaeo/cssquery-jquery.html) 17:24:06 INFO - PROCESS | 32655 | RSS: Main: 241459200 17:24:06 INFO - PROCESS | 32655 | 17:27:08 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39298/tests/dromaeo/cssquery-mootools.html) 17:27:08 INFO - PROCESS | 32655 | RSS: Main: 240361472 17:27:08 INFO - PROCESS | 32655 | 17:30:10 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39298/tests/dromaeo/cssquery-prototype.html) 17:30:11 INFO - PROCESS | 32655 | RSS: Main: 229814272 17:30:11 INFO - PROCESS | 32655 | 17:33:14 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39298/tests/dromaeo/cssquery-yui.html) 17:33:14 INFO - PROCESS | 32655 | RSS: Main: 224120832 17:33:14 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:39298/tests/dromaeo/cssquery-yui.html (next: http://localhost:39298/tests/dromaeo/cssquery-dojo.html) 17:36:17 INFO - PROCESS | 32655 | RSS: Main: 271581184 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | __start_tp_report 17:36:17 INFO - PROCESS | 32655 | _x_x_mozilla_page_load 17:36:17 INFO - PROCESS | 32655 | _x_x_mozilla_page_load_details 17:36:17 INFO - PROCESS | 32655 | |i|pagename|runs| 17:36:17 INFO - PROCESS | 32655 | |0;dojo.html;3206.759493038022;3212.5020621803615;3236.1747754322646;3257.7882437641565;3280.540724298597;5277.868053298669;5351;5365.490278423554;5424.674519528826;5511.779528818847;5407.810726624569;5426.62013659044;5457.808976685817;5534.059209934311;5542.251796007537;4936.062148191841;4952.925706114411;4967.4287456942375;4981.1532039553185;5006.924896126561;4947.925781113287;5079.974600126994;5096.235564665293;5139.306193663845;5140.845774626767;4760.5715485606115;4774.164521208774;5037.093323201822;5060.190369540875;5077.949220507803;4873.293372460973;4881.365422495053;4889.804407823683;4892.486288939681;4898.2162853943555;4831.178699621073;4850.442199147108;4850.975745121287;4853.927191092136;4855.198892182786;5386.084365657847;5454.4545545445535;5474.151506516497;5484.972575137099;5490.670559766387;5873.177755114288;5919.91120133194;5920.082387229986;5922.822315330547;5931.051031834929;5638.492535671769;5838.678872662044;5874.97062514689;5885.911711324334;5962.910556341659;5505.862353441156;5520.53075488588;5524.723763811793;5580.135079062752;5584.301962254718;6037;6049.697515124226;6087.360827113178;6096.756129754849;6105.816825495153;5613.270274864241;5705.800296989669;5715.1713001614535;5739.540836733051;5848.561357898175;5919.3192782829665;5922.082077278029;5923.940760592425;5925.4370834770625;5928.644281343133;5660.886782264414;5876.529877609781;5891.440313170242;5892.204552385459;5902.05567109269;5817.88364232713;5852.268466441695;5867.530597552186;5900.468957793819;5925.318588362307;4498.527654596286;4503.054358584668;4505.797239124247;4506.053728716941;4540.364348991144;3905.9609403905597;3957.0700885291935;4017.738846974996;4039.1517781265675;4064.146529228836;5495.697736624444;5571.582131340166;5580.469855363734;5599.80400685974;5638.915416268759;5910.083936989773;5926.762929482772;5931.911021334683;5932.555058370639;5937.643741375531;5401.135818269058;5517.69652669107;5535.252740880011;5590.5248053915875;5591.608587398843;5095.388553373545;5101.846944591668;5109.4379618241965;5114.28400023997;5154.201098829687;6108.694565271719;6154;6155.045967874987;6169.876602467925;6176.382361763877;5668.829935101953;5826.126081087701;5867.618604790675;5931.317898441562;5953.434423729739;6158.199434073542;6159.538034647509;6172.043333283348;6175.84560385994;6178.876422471435;5812.418758124154;5815.5929084963645;5819.388964158702;5819.592628516132;5849.239598852122;5704.401037890962;5761.164631128379;5764.135379692912;5794.565407594363;5914.378990205966;5664.122061080539;5691.857703557444;5692.089265717465;5699.629524080921;5704;5692.544596432358;5702.743376547983;5703.486686198262;5706.657600543981;5709.571782116275;5495.395506494203;5561.4716601922755;5582.134769110794;5599.04816181242;5658.179563963285;5775.075987841925;5831.067029275296;5831.766729330949;5835.67903765297;5839.708014599338;5459.044667183306;5613.74738136793;5660.037793575185;5660.51885589713;5664.745086471036 17:36:17 INFO - PROCESS | 32655 | |1;ext.html;596.1326270276747;635.4535099814159;640.1454058831462;646.6766616691654;649.7303618998116;43744.562554374446;44497;44886.32670509941;45282.32076518851;48916.51083489164;46465;47248.76375618126;47263.29105063427;47270.29094563585;47343.52656473434;8032.959835200816;8188.590570471482;8192.344612431021;8979.640814367418;9115.042920493352;8201.876971845428;10396.324238924484;10611.416372099531;10613.73465663357;10997.835032474519;10769.515371808247;10826.512806923707;10827.07969822566;10833;10834;7934.603269836485;10442.738931526697;10612.946935265312;10652.680419587463;10668.626598069108;10281.280310378277;10735.141188704885;10748.462576871125;10748.946255268751;10754.139668826476;42194.78902605498;42647.57352426467;42649.36025959613;42742.145157096995;42855.78572107151;3480.3909315869623;3484.163800687842;3499.0902365384927;3536.522569453117;3544.61009288978;30568.388632227452;30823.845880770452;30854.691453085405;33887;33917.49123763145;4347.260965635818;4443.400140980991;4482.372467854503;4494.16857881293;4595.517470665599;326134;326574;328256;328289.9999999976;328925;35551;36587.63412365896;61898.38101618926;63205.36794632087;63242.0513692295;38528.76183619856;38530.22939541194;38681;38716;38717.806410967765;15701.214939252992;15745.370185192693;15786.289616967264;15834.129122898352;15834.52496425086;11846.407679615984;12061.457234424297;12071.698207544881;12584.18202816814;12946.546870859474;8654.826903461895;8708.477491350539;8730.781730456662;8804.647814087493;8841.16008979146;3338.3490219407468;3341;3371;3373.2578832656777;3381.966180338214;1071.3304184884448;1099.2960910588556;1100.834874768791;1119.770447058351;1196.2284326609288;33482.3303533928;33887.49168762471;33889.32221355559;34189.48715769265;34249;1184.6189159788714;1194.5878671858368;1198.5505435461703;1245.9439325230387;1271.2436100520176;17354.566135846453;17899.02296384277;17907.121980464985;18084.367047153286;18098.21776636033;154418;154682;155191;155924.22037889966;156496;60941.39058609357;60958;61265.69367153225;61353.38646613566;61586.69206653938;1310.1156719214491;1410.3230449384148;1419.6025112968384;1433.2475450388422;1459.3797636004656;30610.693893060783;34046;34290.314193716484;34607.480887787206;34960.475592866635;52386.21420678769;56924.430755691916;58481;58867;64603.353966459734;516219.4189029031;517730;524608;524960;525827;37300.440493393166;38520.6147938517;39658.40512392259;45350.54649453463;45818.541814581426;46956.295655564514;50368.496315037846;50820.74589627028;51646.48353516567;52116.73941630419;41216.38175427431;42783.572164279205;43302.78348608237;43368.34947475727;44463.33305000492;41761.79119104385;42217.155656887306;42364;42438.57561424346;43297;42160.36759448549;42557.57442425536;43858.342124867515;43994.900127497065;44041.77979110212;36504.81747591245;37281.81359093187;37571.62428375681;38344.23311533698;38354.61645383511;29170.854145729983;29479.936404451484;29570.556441653822;29785;29897.70102299036 17:36:17 INFO - PROCESS | 32655 | |2;jquery.html;402.863026570966;404.6095517825298;408.3568379801812;408.4057696052244;421.13036579463403;13619.863801361984;18342.724859127105;18860.339888103917;20119.396418107463;20119.899400502996;17720.379786707468;18191;18391.632167356645;19949.900250498762;20101.195952161896;5866.237389139416;6018.7893423730175;6027.578069535134;6032.125341825433;6060.969695151518;5910.113482977545;5963.970180149093;5966.8806623867495;5971.641701497902;5976.641401515902;4194.643455306287;4732;6588.769393071243;6601.075849381066;6707.832304192385;5314.840554783363;5703.828885133453;6605.504587155959;6646.833829154238;6669.399754022137;5426.891462170774;5582.91625625616;5613.129964855454;5614.382417934024;5623.522000629951;14224.217668028254;14469.638259043502;14490.637734056627;14495.71008579833;14992.775108373275;2257.24382331919;2292.4727312718;2416.371743346725;2450.301664025762;2523.570992931206;10643.680689579325;10889.782204355948;12948.417321220568;14039.64900877476;14110;1993.5016245938516;1999.62007218628;2068.7626805182385;2100.306898723418;2144.5603651251454;69036;81991.59004205001;85758;87081.56459217664;87334.5633271836;10887.074598659045;11059;11288.379139147426;11464.770704585862;11561.30632162073;15804.288807003712;15943.681126377407;15969.201539922957;16015.759763603555;16044.117573533335;8235.423520353517;8415.831683366298;8425.957870210732;8616.870746938801;8631.525266110424;8291.8341633167;8295.585220738938;8302.667893284322;8419.579021049045;8421.536815475085;4842.055799119138;4863.489333619989;4944.269505672985;4978.4274808397495;4990.90018199634;1941.8155275248828;1995.4013795861183;2040.5306779440514;2048.621005114059;2054.085931760382;988.3279370028306;1016.4561959351711;1064;1105.6019832860163;1147.1969621265148;18932.24271029171;19514.21943122259;19643.705344419846;19809.306674266332;20011.099500522512;1016.3850870223556;1022.2384323678758;1053.8629978102797;1055.1137044882337;1062.6918193723889;10651.467426628638;11135;11350.432478376048;11401.315921044765;11435.59975400857;475259;479705;491272;493057;493680;73618.63190684012;84276;87792;91113.44611048193;93784.5932311016;1043.7860238651058;1045.8744950605976;1090.9181811364022;1112.404863398078;1118.0887576625187;16391.180440977663;16783.916080420007;16885.40901068457;16959;17171.399001034904;40109.79945100256;41443.1711365777;41573;42120.26218295801;42984.57015429805;51084;51650.48349516457;55368.44631553794;57667.7116614431;57892.71053644705;8868.11318868108;8945.910540894507;9080.954595226982;9126;9395.436273823592;12895.6471964362;14017.929910350384;14031.719365612427;14061.507847225706;14314;12087.758244834878;12377;12419.503219871465;12446.315452650191;12474.251544907334;12114.394280286127;12148;12226.572069977508;12491.937540312603;12527.18573292733;12598;12657.114002020138;12692.873071269538;12709.745805084032;12818.807717884052;8829.64681412762;9070.45024367718;9092.95386045682;9147.131022552847;9249.907500924905;9447.244220462484;11734.823977640172;12453.75092498163;12462.43919023628;12497.125201235825 17:36:17 INFO - PROCESS | 32655 | |3;mootools.html;1395.3162950154428;1581.8339074397188;1592.992035039825;1768.3280353465682;1914.1386376130736;8761.342899282547;9055.683051093205;9077.273818094545;9398.201152902011;9416.905830941689;9119.817603647924;9311.20854727349;9311.906880931188;9314.441133531993;9319.58061887215;2354.423166324253;2381.285614315707;2381.868997205153;2383.0825132324094;2384.2012925669833;2393.652920326552;2408.9638655420094;2447.840890342131;2456.5701002324613;2457.348802567321;2371.739108698042;2392.126873691099;2400.807935365175;2437.890294936732;2440.5362981033636;2306.988465057664;2320.373499155227;2328.2782337475437;2332.626779715246;2349.048635302705;2196.286206982737;2249.2802303262797;2252.3355610094895;2258.3789457899043;2260.480089579406;7722.768316950501;8463.95768021162;9233.21517670992;9293.488858112802;9321.161095501437;5497.835064948058;5651.321841379061;5656.434356564352;5657.15142728594;5659;3496.7377446691344;3624.800635965021;3639.1266096137;3643.6902863256655;3692.4276737105524;1108.695108845066;1113.0872684398796;1117.8323251512256;1147.7761836441898;1151.8502594662723;13274.203547787163;13284.601461956157;13325.600231993056;13441.395137218751;13449.731005379936;4720.763961801897;4724.929126063112;4794.113089078532;4806.807727690853;4899;10237.334573252863;10252.282340236261;10274.126699230499;10275;10276.280660353703;5450.890982180414;5474.7262636868;5477.726113694379;5491.395946445888;5492.5605951523785;5070.467600901926;5086.16078347076;5177.068127737043;5209.244659524347;5241.711705856214;3762.529683789526;3823.6749876260274;3847.499825022785;3879.7866117363815;3896.3960586109197;1193.1267909382186;1207.3480320626938;1221.645722740413;1228.5761412312916;1240.7890658588062;1008.5562352564848;1013.5033833421718;1015.3907655406845;1038.382162613244;1050.138886113395;6224.751009959641;6310.1481300024825;6340.461060809883;6408.423241908251;6432.4532414744335;489.1439980034939;496.05253964926817;496.98862814172986;982.3860087445347;1063.3194755356578;4327.026419055687;4392.670549708785;4477.686561940698;4481.75350355727;4524.253498172765;11623.244489108181;11782.351970641697;11846.229995050295;11883.70290742721;11900.40497975115;11039.944800276107;11584.536618535165;11608.883911160949;11793.174477786473;11837.76324473523;8664.653413863502;8762.299016078698;8792.516411597424;8808.251298639687;8853.114688531225;6050.546209034252;6193.659348735863;6224.408681175281;6257.4994000480765;6272.874542509033;10820.296680715728;10820.5130769114;10827.891721082688;10923.672289831318;10940.343579385262;10986.560537578407;11119.610813621484;11177.497012634614;11241.831372529583;11311.604093856675;8154.266116049584;8163.877541836759;8184.468009579597;8300.958495207486;8308.210719981593;8916.465012099296;9034.503102329172;9051.95474022652;9052.411593246417;9059.773505662411;7868.488548244346;8073.555954422563;8105.473144245605;8192.508449493049;8456.619452124545;8072.273495385443;8103.797405064921;8117;8236.176382361717;8278.917210828056;7430.368418684472;7498.32515073646;7569.5079819811535;7579.772606821804;7581.393488521016;5452.6183167177915;5458.645188062763;5477.178423236546;5499.257600223918;5615.606907516435;5629.26819513477;5754.913676294943;5851.1223316502865;5883.0881213411985;5906.70466476683 17:36:17 INFO - PROCESS | 32655 | |4;prototype.html;337.1571072319202;346.16056064044693;354.629412264184;355;355.1990261959281;5290.1800220965815;5406;5429.972850135749;5487.64330318529;5514.172874068891;5428.891422171554;5429.239906413095;5440.537554307879;5448.918266226;5460.645058071233;4270;4287.699861009715;4292.699511034229;4305.784710764465;4315.633171180438;4065.6544193743566;4125.9174816503655;4298;4316.633086187678;4350.73895566267;4219.409282700424;4238.258304796664;4242.469691288589;4245.9575404246025;4245.9787701061605;4205.201011807762;4215.873523794291;4223.957760422418;4226.661867050644;4228.725132866354;3734.589195188527;3805.5052843130493;3816;3820.4078367853026;3827.0815004399024;5206.526899722601;5216.217567364888;5223.582113430954;5228.346456692913;5245;4886;4887.242477416006;4902.240152776325;4902.803887844482;4917.50824917509;5584.106542953149;5673.375928647845;5691.260136182311;5697.743601537899;5717.341970828455;4189.324270291877;4196.412502249687;4211.768352740598;4219.662427005832;4221.282381995068;5690.687012214326;5801.070459418009;5911.940880591225;5916.940830591682;5961.195238642771;4092.529359123679;4234.491860976703;4236.35227982511;4254.851080212177;4304.428883457515;4287.528371879091;4297.710686794012;4300.247456695066;4300.247456695129;4342.413774140514;4835.903281934342;4848.109237397418;4853.538913803183;4871.8294859679745;4886;5391.299131113009;5587.525060369833;5686.3744988051285;5723.54211663066;5749.195112684228;1371.5611004478671;1418.9003522270323;1442.8268607766925;1457.9416823326949;1467.8091848059898;913.3150137396952;926.7358802741321;936.765808547863;936.9625214991461;946.1673727120228;4809.268663281216;4853.611711063107;4864.197407427735;4866.301610775765;4891.584215341664;5067.569256613156;5080.237964305384;5113.287048838681;5125.820596279113;5217.895642087137;4834.806607735722;4850.442199147073;4870.707757534559;4880.951190488121;5123.205903085028;3079.122450101755;3090.3046814466566;3121.484954982448;3124.078396872928;3128.8122712637314;5997.83042306746;6022.488088512526;6077.270727512639;6079;6090.421409966046;5651.886962260732;5943.524518038633;5945.464908158287;5950.7917222896995;5980.491658209101;6076.544259180668;6086.786962456381;6103.511719062464;6109.969450152721;6119.785807496716;5626.690532020614;5892.587518873637;5902.350741418355;5913.438223368773;5925.703714814328;5782.710864456844;5791.362950075404;5792.609773654377;5819.621724587888;5824.3593204748295;6054.515638748801;6071.574989750675;6101.84745381369;6106.725197366218;6116.186554185125;3962.3660214365564;4186.937195942124;4200.810963506588;4206.242876282298;4213.810378533035;5654.406287339934;5735.655860648374;5761.366249712612;5770.855728606818;5808.867270882306;5564.221009058816;5668.574856885833;5673.3759286477625;5704.231688176513;5781.306243250837;5607.383187849415;5616.21373007771;5670.5180059695385;5686.829395118153;5688;5358.196270559447;5592.51798273466;5602.187682785891;5611.831645050655;5625.887482250414;5742.339630942495;5752.533104058438;5766;5783.7397317119985;5788.594798364074;5419.376771671151;5630.634008789416;5662.57530685192;5675.7445914933105;5679.858003549944 17:36:17 INFO - PROCESS | 32655 | |5;yui.html;786.2412771675332;806.3750593290199;815.2228142649022;841.1420351241734;841.2134654098419;14737.778933315996;15266.69466610667;15357.539273821776;15362.846371536309;15387.384504619817;12051;14075.436982520712;14103;14103.365348559313;14121.082129661565;817.9713710020136;842.3513894301384;844.7592436155696;845.9788505287386;848.088305072047;834.3908946469081;835.2566216067675;838.2832678060262;841.1252297610508;841.4446465332851;730.1749023603321;854.7008547008528;889.1997202517754;889.4174315823146;890.3278025091047;865.3207232322628;867.9913200867974;868.3140319147866;868.8522951098329;871.4945331707626;631.2803404119308;631.6241836107555;631.6399652198248;631.6967855429419;631.9399657032575;13613.11514751538;13615.591532254048;13656.112352697042;13691.794623080661;13694.383752731152;13553.864461355359;13789.379477923518;13792.793108103386;13829;13931.58205253844;12571;12743.107982441234;12817.743645127046;12957.805632915513;12994.610161695164;4479.283314669669;4486.237339652267;4499.865004049884;4505.256632655608;4602.677812553089;59840.700796496174;59884;60030.69984650049;60118;60766.08850867241;11268.323900565993;11268.492917818554;11440.656780296604;11486.42567871603;11521.711957201138;20162.092705828272;20172.899135504227;20201.797982020285;20237.595248094956;20918.267860624805;8161.387895907831;8202.343812494986;8230.83538329242;8258.050324212672;8365.456245344034;4653.60444362233;4771.498992605726;4813.711177329302;4881.292212629149;4888.486708895586;3532.699720523733;3564.3049605326714;3630.473581330745;3636.30910127075;3638.235970446236;648.3905129178557;649.4804156674642;656.9868602628017;659.7394029358377;671.2280876991401;649.4544582550681;706.2972342519226;707.9787606371817;713.3080911515822;713.3437237741291;8731.956340218258;8996.775080623036;9034.45793252407;9170.724878253663;9264.490453025148;687.5118665747375;690.1407747354576;696.9303069692991;708.0618180910211;721.2246834652769;4136.4415803866095;4361.258586040381;4391.538888416734;4395.978020109879;4431.224535706238;71185.88141185943;72138.63930680418;74196;74417;74816.25183748093;65296.673516632116;65854.34145658578;65939.34060659428;66255.66872165704;67485;59900;60050;60893.39106608966;60970.39029609647;61454;8102;8143.470674406145;8180.8363832721825;8400.663973441238;9137.177654011171;34644.65355346515;35741.46387804237;36667.26665466622;37280;37465.43801843029;48953;50025.749871251865;50721.74639126781;50928.490715092375;51112;12695.301758403377;12812.807807883075;13107.410166542719;13173.143745656502;13349.199048057148;13011.21932684004;14103.506377276746;14911.552653420415;15033.849661503682;15342.539723808304;13143.211407315592;13149.276789776271;13697.08859687998;13944.651383715489;14124.223167725462;13782.517611883535;13922;14098.36557354942;14270.571882843531;14890.77663835065;12120.575779847662;12815.16701414405;12896.29070401137;13301.401436935168;13415.396307166397;11277.492512837107;11494.827577586175;11542.711432213926;11608.593699220486;11848.229865058744;11262.817240644585;11457.770844582896;11497;11516.884831151916;11652.53389864396 17:36:17 INFO - PROCESS | 32655 | __end_tp_report 17:36:17 INFO - PROCESS | 32655 | __start_cc_report 17:36:17 INFO - PROCESS | 32655 | _x_x_mozilla_cycle_collect,838 17:36:17 INFO - PROCESS | 32655 | __end_cc_report 17:36:17 INFO - PROCESS | 32655 | __startTimestamp1463186177372__endTimestamp 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | ------- Summary: start ------- 17:36:17 INFO - PROCESS | 32655 | Number of tests: 6 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#0] dojo.html Cycles:165 Average:5450.47 Median:5638.92 stddev:624.40 (11.1%) stddev-sans-first:600.99 17:36:17 INFO - PROCESS | 32655 | Values: 3206.8 3212.5 3236.2 3257.8 3280.5 5277.9 5351.0 5365.5 5424.7 5511.8 5407.8 5426.6 5457.8 5534.1 5542.3 4936.1 4952.9 4967.4 4981.2 5006.9 4947.9 5080.0 5096.2 5139.3 5140.8 4760.6 4774.2 5037.1 5060.2 5077.9 4873.3 4881.4 4889.8 4892.5 4898.2 4831.2 4850.4 4851.0 4853.9 4855.2 5386.1 5454.5 5474.2 5485.0 5490.7 5873.2 5919.9 5920.1 5922.8 5931.1 5638.5 5838.7 5875.0 5885.9 5962.9 5505.9 5520.5 5524.7 5580.1 5584.3 6037.0 6049.7 6087.4 6096.8 6105.8 5613.3 5705.8 5715.2 5739.5 5848.6 5919.3 5922.1 5923.9 5925.4 5928.6 5660.9 5876.5 5891.4 5892.2 5902.1 5817.9 5852.3 5867.5 5900.5 5925.3 4498.5 4503.1 4505.8 4506.1 4540.4 3906.0 3957.1 4017.7 4039.2 4064.1 5495.7 5571.6 5580.5 5599.8 5638.9 5910.1 5926.8 5931.9 5932.6 5937.6 5401.1 5517.7 5535.3 5590.5 5591.6 5095.4 5101.8 5109.4 5114.3 5154.2 6108.7 6154.0 6155.0 6169.9 6176.4 5668.8 5826.1 5867.6 5931.3 5953.4 6158.2 6159.5 6172.0 6175.8 6178.9 5812.4 5815.6 5819.4 5819.6 5849.2 5704.4 5761.2 5764.1 5794.6 5914.4 5664.1 5691.9 5692.1 5699.6 5704.0 5692.5 5702.7 5703.5 5706.7 5709.6 5495.4 5561.5 5582.1 5599.0 5658.2 5775.1 5831.1 5831.8 5835.7 5839.7 5459.0 5613.7 5660.0 5660.5 5664.7 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#1] ext.html Cycles:180 Average:51616.48 Median:36934.72 stddev:97786.18 (264.8%) stddev-sans-first:97985.46 17:36:17 INFO - PROCESS | 32655 | Values: 596.1 635.5 640.1 646.7 649.7 43744.6 44497.0 44886.3 45282.3 48916.5 46465.0 47248.8 47263.3 47270.3 47343.5 8033.0 8188.6 8192.3 8979.6 9115.0 8201.9 10396.3 10611.4 10613.7 10997.8 10769.5 10826.5 10827.1 10833.0 10834.0 7934.6 10442.7 10612.9 10652.7 10668.6 10281.3 10735.1 10748.5 10748.9 10754.1 42194.8 42647.6 42649.4 42742.1 42855.8 3480.4 3484.2 3499.1 3536.5 3544.6 30568.4 30823.8 30854.7 33887.0 33917.5 4347.3 4443.4 4482.4 4494.2 4595.5 326134.0 326574.0 328256.0 328290.0 328925.0 35551.0 36587.6 61898.4 63205.4 63242.1 38528.8 38530.2 38681.0 38716.0 38717.8 15701.2 15745.4 15786.3 15834.1 15834.5 11846.4 12061.5 12071.7 12584.2 12946.5 8654.8 8708.5 8730.8 8804.6 8841.2 3338.3 3341.0 3371.0 3373.3 3382.0 1071.3 1099.3 1100.8 1119.8 1196.2 33482.3 33887.5 33889.3 34189.5 34249.0 1184.6 1194.6 1198.6 1245.9 1271.2 17354.6 17899.0 17907.1 18084.4 18098.2 154418.0 154682.0 155191.0 155924.2 156496.0 60941.4 60958.0 61265.7 61353.4 61586.7 1310.1 1410.3 1419.6 1433.2 1459.4 30610.7 34046.0 34290.3 34607.5 34960.5 52386.2 56924.4 58481.0 58867.0 64603.4 516219.4 517730.0 524608.0 524960.0 525827.0 37300.4 38520.6 39658.4 45350.5 45818.5 46956.3 50368.5 50820.7 51646.5 52116.7 41216.4 42783.6 43302.8 43368.3 44463.3 41761.8 42217.2 42364.0 42438.6 43297.0 42160.4 42557.6 43858.3 43994.9 44041.8 36504.8 37281.8 37571.6 38344.2 38354.6 29170.9 29479.9 29570.6 29785.0 29897.7 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#2] jquery.html Cycles:180 Average:28685.62 Median:2084.53 stddev:80115.76 (3843.3%) stddev-sans-first:80312.36 17:36:17 INFO - PROCESS | 32655 | Values: 402.9 404.6 408.4 408.4 421.1 13619.9 18342.7 18860.3 20119.4 20119.9 17720.4 18191.0 18391.6 19949.9 20101.2 5866.2 6018.8 6027.6 6032.1 6061.0 5910.1 5964.0 5966.9 5971.6 5976.6 4194.6 4732.0 6588.8 6601.1 6707.8 5314.8 5703.8 6605.5 6646.8 6669.4 5426.9 5582.9 5613.1 5614.4 5623.5 14224.2 14469.6 14490.6 14495.7 14992.8 2257.2 2292.5 2416.4 2450.3 2523.6 10643.7 10889.8 12948.4 14039.6 14110.0 1993.5 1999.6 2068.8 2100.3 2144.6 69036.0 81991.6 85758.0 87081.6 87334.6 10887.1 11059.0 11288.4 11464.8 11561.3 15804.3 15943.7 15969.2 16015.8 16044.1 8235.4 8415.8 8426.0 8616.9 8631.5 8291.8 8295.6 8302.7 8419.6 8421.5 4842.1 4863.5 4944.3 4978.4 4990.9 1941.8 1995.4 2040.5 2048.6 2054.1 988.3 1016.5 1064.0 1105.6 1147.2 18932.2 19514.2 19643.7 19809.3 20011.1 1016.4 1022.2 1053.9 1055.1 1062.7 10651.5 11135.0 11350.4 11401.3 11435.6 475259.0 479705.0 491272.0 493057.0 493680.0 73618.6 84276.0 87792.0 91113.4 93784.6 1043.8 1045.9 1090.9 1112.4 1118.1 16391.2 16783.9 16885.4 16959.0 17171.4 40109.8 41443.2 41573.0 42120.3 42984.6 51084.0 51650.5 55368.4 57667.7 57892.7 8868.1 8945.9 9081.0 9126.0 9395.4 12895.6 14017.9 14031.7 14061.5 14314.0 12087.8 12377.0 12419.5 12446.3 12474.3 12114.4 12148.0 12226.6 12491.9 12527.2 12598.0 12657.1 12692.9 12709.7 12818.8 8829.6 9070.5 9093.0 9147.1 9249.9 9447.2 11734.8 12453.8 12462.4 12497.1 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#3] mootools.html Cycles:180 Average:6122.94 Median:4622.51 stddev:3545.30 (76.7%) stddev-sans-first:3537.44 17:36:17 INFO - PROCESS | 32655 | Values: 1395.3 1581.8 1593.0 1768.3 1914.1 8761.3 9055.7 9077.3 9398.2 9416.9 9119.8 9311.2 9311.9 9314.4 9319.6 2354.4 2381.3 2381.9 2383.1 2384.2 2393.7 2409.0 2447.8 2456.6 2457.3 2371.7 2392.1 2400.8 2437.9 2440.5 2307.0 2320.4 2328.3 2332.6 2349.0 2196.3 2249.3 2252.3 2258.4 2260.5 7722.8 8464.0 9233.2 9293.5 9321.2 5497.8 5651.3 5656.4 5657.2 5659.0 3496.7 3624.8 3639.1 3643.7 3692.4 1108.7 1113.1 1117.8 1147.8 1151.9 13274.2 13284.6 13325.6 13441.4 13449.7 4720.8 4724.9 4794.1 4806.8 4899.0 10237.3 10252.3 10274.1 10275.0 10276.3 5450.9 5474.7 5477.7 5491.4 5492.6 5070.5 5086.2 5177.1 5209.2 5241.7 3762.5 3823.7 3847.5 3879.8 3896.4 1193.1 1207.3 1221.6 1228.6 1240.8 1008.6 1013.5 1015.4 1038.4 1050.1 6224.8 6310.1 6340.5 6408.4 6432.5 489.1 496.1 497.0 982.4 1063.3 4327.0 4392.7 4477.7 4481.8 4524.3 11623.2 11782.4 11846.2 11883.7 11900.4 11039.9 11584.5 11608.9 11793.2 11837.8 8664.7 8762.3 8792.5 8808.3 8853.1 6050.5 6193.7 6224.4 6257.5 6272.9 10820.3 10820.5 10827.9 10923.7 10940.3 10986.6 11119.6 11177.5 11241.8 11311.6 8154.3 8163.9 8184.5 8301.0 8308.2 8916.5 9034.5 9052.0 9052.4 9059.8 7868.5 8073.6 8105.5 8192.5 8456.6 8072.3 8103.8 8117.0 8236.2 8278.9 7430.4 7498.3 7569.5 7579.8 7581.4 5452.6 5458.6 5477.2 5499.3 5615.6 5629.3 5754.9 5851.1 5883.1 5906.7 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#4] prototype.html Cycles:180 Average:4755.65 Median:5324.19 stddev:1389.23 (26.1%) stddev-sans-first:1352.96 17:36:17 INFO - PROCESS | 32655 | Values: 337.2 346.2 354.6 355.0 355.2 5290.2 5406.0 5430.0 5487.6 5514.2 5428.9 5429.2 5440.5 5448.9 5460.6 4270.0 4287.7 4292.7 4305.8 4315.6 4065.7 4125.9 4298.0 4316.6 4350.7 4219.4 4238.3 4242.5 4246.0 4246.0 4205.2 4215.9 4224.0 4226.7 4228.7 3734.6 3805.5 3816.0 3820.4 3827.1 5206.5 5216.2 5223.6 5228.3 5245.0 4886.0 4887.2 4902.2 4902.8 4917.5 5584.1 5673.4 5691.3 5697.7 5717.3 4189.3 4196.4 4211.8 4219.7 4221.3 5690.7 5801.1 5911.9 5916.9 5961.2 4092.5 4234.5 4236.4 4254.9 4304.4 4287.5 4297.7 4300.2 4300.2 4342.4 4835.9 4848.1 4853.5 4871.8 4886.0 5391.3 5587.5 5686.4 5723.5 5749.2 1371.6 1418.9 1442.8 1457.9 1467.8 913.3 926.7 936.8 937.0 946.2 4809.3 4853.6 4864.2 4866.3 4891.6 5067.6 5080.2 5113.3 5125.8 5217.9 4834.8 4850.4 4870.7 4881.0 5123.2 3079.1 3090.3 3121.5 3124.1 3128.8 5997.8 6022.5 6077.3 6079.0 6090.4 5651.9 5943.5 5945.5 5950.8 5980.5 6076.5 6086.8 6103.5 6110.0 6119.8 5626.7 5892.6 5902.4 5913.4 5925.7 5782.7 5791.4 5792.6 5819.6 5824.4 6054.5 6071.6 6101.8 6106.7 6116.2 3962.4 4186.9 4200.8 4206.2 4213.8 5654.4 5735.7 5761.4 5770.9 5808.9 5564.2 5668.6 5673.4 5704.2 5781.3 5607.4 5616.2 5670.5 5686.8 5688.0 5358.2 5592.5 5602.2 5611.8 5625.9 5742.3 5752.5 5766.0 5783.7 5788.6 5419.4 5630.6 5662.6 5675.7 5679.9 17:36:17 INFO - PROCESS | 32655 | 17:36:17 INFO - PROCESS | 32655 | [#5] yui.html Cycles:180 Average:16361.08 Median:4712.55 stddev:19973.47 (423.8%) stddev-sans-first:19995.26 17:36:17 INFO - PROCESS | 32655 | Values: 786.2 806.4 815.2 841.1 841.2 14737.8 15266.7 15357.5 15362.8 15387.4 12051.0 14075.4 14103.0 14103.4 14121.1 818.0 842.4 844.8 846.0 848.1 834.4 835.3 838.3 841.1 841.4 730.2 854.7 889.2 889.4 890.3 865.3 868.0 868.3 868.9 871.5 631.3 631.6 631.6 631.7 631.9 13613.1 13615.6 13656.1 13691.8 13694.4 13553.9 13789.4 13792.8 13829.0 13931.6 12571.0 12743.1 12817.7 12957.8 12994.6 4479.3 4486.2 4499.9 4505.3 4602.7 59840.7 59884.0 60030.7 60118.0 60766.1 11268.3 11268.5 11440.7 11486.4 11521.7 20162.1 20172.9 20201.8 20237.6 20918.3 8161.4 8202.3 8230.8 8258.1 8365.5 4653.6 4771.5 4813.7 4881.3 4888.5 3532.7 3564.3 3630.5 3636.3 3638.2 648.4 649.5 657.0 659.7 671.2 649.5 706.3 708.0 713.3 713.3 8732.0 8996.8 9034.5 9170.7 9264.5 687.5 690.1 696.9 708.1 721.2 4136.4 4361.3 4391.5 4396.0 4431.2 71185.9 72138.6 74196.0 74417.0 74816.3 65296.7 65854.3 65939.3 66255.7 67485.0 59900.0 60050.0 60893.4 60970.4 61454.0 8102.0 8143.5 8180.8 8400.7 9137.2 34644.7 35741.5 36667.3 37280.0 37465.4 48953.0 50025.7 50721.7 50928.5 51112.0 12695.3 12812.8 13107.4 13173.1 13349.2 13011.2 14103.5 14911.6 15033.8 15342.5 13143.2 13149.3 13697.1 13944.7 14124.2 13782.5 13922.0 14098.4 14270.6 14890.8 12120.6 12815.2 12896.3 13301.4 13415.4 11277.5 11494.8 11542.7 11608.6 11848.2 11262.8 11457.8 11497.0 11516.9 11652.5 17:36:17 INFO - PROCESS | 32655 | -------- Summary: end -------- 17:36:17 INFO - PROCESS | 32655 | 17:36:18 INFO - TEST-INFO | 32655: exit 0 17:36:18 INFO - TEST-OK | dromaeo_css | took 1112534ms 17:36:18 INFO - TEST-START | kraken 17:36:18 INFO - operating with platform_type : linux_ 17:36:18 INFO - Initialising browser for kraken test... 17:36:18 INFO - TEST-INFO | started process 369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__C39i/profile http://localhost:39298/getInfo.html) 17:36:21 INFO - PROCESS | 369 | __metrics Screen width/height:1600/1200 17:36:21 INFO - PROCESS | 369 | colorDepth:24 17:36:21 INFO - PROCESS | 369 | Browser inner width/height: 1024/697 17:36:21 INFO - PROCESS | 369 | __metrics 17:36:22 ERROR - PROCESS | 369 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:36:23 INFO - TEST-INFO | 369: exit 0 17:36:23 INFO - Browser initialized. 17:36:23 INFO - Running cycle 1/1 for kraken test... 17:36:23 INFO - TEST-INFO | started process 453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__C39i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:35 INFO - PROCESS | 453 | RSS: Main: 152768512 17:36:35 INFO - PROCESS | 453 | 17:36:37 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39298/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:38 INFO - PROCESS | 453 | RSS: Main: 208236544 17:36:38 INFO - PROCESS | 453 | 17:36:41 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39298/tests/kraken/driver.html?testName=audio-dft) 17:36:41 INFO - PROCESS | 453 | RSS: Main: 196911104 17:36:41 INFO - PROCESS | 453 | 17:36:45 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39298/tests/kraken/driver.html?testName=audio-fft) 17:36:45 INFO - PROCESS | 453 | RSS: Main: 264994816 17:36:45 INFO - PROCESS | 453 | 17:36:47 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39298/tests/kraken/driver.html?testName=audio-oscillator) 17:36:48 INFO - PROCESS | 453 | RSS: Main: 174522368 17:36:48 INFO - PROCESS | 453 | 17:36:50 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:51 INFO - PROCESS | 453 | RSS: Main: 179568640 17:36:51 INFO - PROCESS | 453 | 17:36:54 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39298/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:55 INFO - PROCESS | 453 | RSS: Main: 214462464 17:36:55 INFO - PROCESS | 453 | 17:36:58 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39298/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:59 INFO - PROCESS | 453 | RSS: Main: 215142400 17:36:59 INFO - PROCESS | 453 | 17:37:02 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39298/tests/kraken/driver.html?testName=json-parse-financial) 17:37:02 INFO - PROCESS | 453 | RSS: Main: 215154688 17:37:02 INFO - PROCESS | 453 | 17:37:04 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:05 INFO - PROCESS | 453 | RSS: Main: 200613888 17:37:05 INFO - PROCESS | 453 | 17:37:06 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:07 INFO - PROCESS | 453 | RSS: Main: 204988416 17:37:07 INFO - PROCESS | 453 | 17:37:09 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:10 INFO - PROCESS | 453 | RSS: Main: 216100864 17:37:10 INFO - PROCESS | 453 | 17:37:12 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:13 INFO - PROCESS | 453 | RSS: Main: 223690752 17:37:13 INFO - PROCESS | 453 | 17:37:16 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:17 INFO - PROCESS | 453 | RSS: Main: 219389952 17:37:17 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | Cycle 1(1): loaded http://localhost:39298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39298/tests/kraken/driver.html?testName=ai-astar) 17:37:18 INFO - PROCESS | 453 | RSS: Main: 265019392 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | __start_tp_report 17:37:18 INFO - PROCESS | 453 | _x_x_mozilla_page_load 17:37:18 INFO - PROCESS | 453 | _x_x_mozilla_page_load_details 17:37:18 INFO - PROCESS | 453 | |i|pagename|runs| 17:37:18 INFO - PROCESS | 453 | |0;ai-astar;109;105;111;109;109;110;108;110;110;108 17:37:18 INFO - PROCESS | 453 | |1;audio-beat-detection;153;127;148;217;127;157;150;126;177;126 17:37:18 INFO - PROCESS | 453 | |2;audio-dft;163;160;161;160;160;160;161;161;160;163 17:37:18 INFO - PROCESS | 453 | |3;audio-fft;76;75;74;146;74;75;76;76;139;84 17:37:18 INFO - PROCESS | 453 | |4;audio-oscillator;92;92;146;94;92;94;119;92;92;127 17:37:18 INFO - PROCESS | 453 | |5;imaging-gaussian-blur;117;117;117;118;118;118;119;118;118;118 17:37:18 INFO - PROCESS | 453 | |6;imaging-darkroom;146;145;146;146;145;146;146;146;145;146 17:37:18 INFO - PROCESS | 453 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 17:37:18 INFO - PROCESS | 453 | |8;json-parse-financial;59;58;57;58;58;58;57;111;55;55 17:37:18 INFO - PROCESS | 453 | |9;json-stringify-tinderbox;59;60;59;59;59;59;59;58;60;59 17:37:18 INFO - PROCESS | 453 | |10;stanford-crypto-aes;79;80;79;78;79;79;79;79;86;85 17:37:18 INFO - PROCESS | 453 | |11;stanford-crypto-ccm;130;121;121;128;127;123;125;126;199;122 17:37:18 INFO - PROCESS | 453 | |12;stanford-crypto-pbkdf2;164;163;161;169;158;167;163;168;160;159 17:37:18 INFO - PROCESS | 453 | |13;stanford-crypto-sha256-iterative;67;62;63;63;63;65;63;62;64;62 17:37:18 INFO - PROCESS | 453 | __end_tp_report 17:37:18 INFO - PROCESS | 453 | __start_cc_report 17:37:18 INFO - PROCESS | 453 | _x_x_mozilla_cycle_collect,1826 17:37:18 INFO - PROCESS | 453 | __end_cc_report 17:37:18 INFO - PROCESS | 453 | __startTimestamp1463186238962__endTimestamp 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | ------- Summary: start ------- 17:37:18 INFO - PROCESS | 453 | Number of tests: 14 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:1.66 (1.5%) stddev-sans-first:1.76 17:37:18 INFO - PROCESS | 453 | Values: 109.0 105.0 111.0 109.0 109.0 110.0 108.0 110.0 110.0 108.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:151.50 stddev:28.84 (19.0%) stddev-sans-first:30.57 17:37:18 INFO - PROCESS | 453 | Values: 153.0 127.0 148.0 217.0 127.0 157.0 150.0 126.0 177.0 126.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.00 17:37:18 INFO - PROCESS | 453 | Values: 163.0 160.0 161.0 160.0 160.0 160.0 161.0 161.0 160.0 163.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.50 stddev:28.13 (37.3%) stddev-sans-first:29.41 17:37:18 INFO - PROCESS | 453 | Values: 76.0 75.0 74.0 146.0 74.0 75.0 76.0 76.0 139.0 84.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:19.54 (21.2%) stddev-sans-first:20.24 17:37:18 INFO - PROCESS | 453 | Values: 92.0 92.0 146.0 94.0 92.0 94.0 119.0 92.0 92.0 127.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 17:37:18 INFO - PROCESS | 453 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:37:18 INFO - PROCESS | 453 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:37:18 INFO - PROCESS | 453 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:58.00 stddev:17.06 (29.4%) stddev-sans-first:18.04 17:37:18 INFO - PROCESS | 453 | Values: 59.0 58.0 57.0 58.0 58.0 58.0 57.0 111.0 55.0 55.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 17:37:18 INFO - PROCESS | 453 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 59.0 58.0 60.0 59.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:2.79 (3.5%) stddev-sans-first:2.92 17:37:18 INFO - PROCESS | 453 | Values: 79.0 80.0 79.0 78.0 79.0 79.0 79.0 79.0 86.0 85.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:126.50 stddev:23.67 (18.7%) stddev-sans-first:25.09 17:37:18 INFO - PROCESS | 453 | Values: 130.0 121.0 121.0 128.0 127.0 123.0 125.0 126.0 199.0 122.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:3.82 (2.3%) stddev-sans-first:4.04 17:37:18 INFO - PROCESS | 453 | Values: 164.0 163.0 161.0 169.0 158.0 167.0 163.0 168.0 160.0 159.0 17:37:18 INFO - PROCESS | 453 | 17:37:18 INFO - PROCESS | 453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.00 17:37:18 INFO - PROCESS | 453 | Values: 67.0 62.0 63.0 63.0 63.0 65.0 63.0 62.0 64.0 62.0 17:37:18 INFO - PROCESS | 453 | -------- Summary: end -------- 17:37:18 INFO - PROCESS | 453 | 17:37:19 INFO - TEST-INFO | 453: exit 0 17:37:19 INFO - TEST-OK | kraken | took 61807ms 17:37:19 INFO - SUITE-END | took 1174s 17:37:20 INFO - Completed test suite (00:19:34) 17:37:20 INFO - javascript benchmark 17:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.759493038022, 3212.5020621803615, 3236.1747754322646, 3257.7882437641565, 3280.540724298597, 5277.868053298669, 5351.0, 5365.490278423554, 5424.674519528826, 5511.779528818847, 5407.810726624569, 5426.62013659044, 5457.808976685817, 5534.059209934311, 5542.251796007537, 4936.062148191841, 4952.925706114411, 4967.4287456942375, 4981.1532039553185, 5006.924896126561, 4947.925781113287, 5079.974600126994, 5096.235564665293, 5139.306193663845, 5140.845774626767, 4760.5715485606115, 4774.164521208774, 5037.093323201822, 5060.190369540875, 5077.949220507803, 4873.293372460973, 4881.365422495053, 4889.804407823683, 4892.486288939681, 4898.2162853943555, 4831.178699621073, 4850.442199147108, 4850.975745121287, 4853.927191092136, 4855.198892182786, 5386.084365657847, 5454.4545545445535, 5474.151506516497, 5484.972575137099, 5490.670559766387, 5873.177755114288, 5919.91120133194, 5920.082387229986, 5922.822315330547, 5931.051031834929, 5638.492535671769, 5838.678872662044, 5874.97062514689, 5885.911711324334, 5962.910556341659, 5505.862353441156, 5520.53075488588, 5524.723763811793, 5580.135079062752, 5584.301962254718, 6037.0, 6049.697515124226, 6087.360827113178, 6096.756129754849, 6105.816825495153, 5613.270274864241, 5705.800296989669, 5715.1713001614535, 5739.540836733051, 5848.561357898175, 5919.3192782829665, 5922.082077278029, 5923.940760592425, 5925.4370834770625, 5928.644281343133, 5660.886782264414, 5876.529877609781, 5891.440313170242, 5892.204552385459, 5902.05567109269, 5817.88364232713, 5852.268466441695, 5867.530597552186, 5900.468957793819, 5925.318588362307, 4498.527654596286, 4503.054358584668, 4505.797239124247, 4506.053728716941, 4540.364348991144, 3905.9609403905597, 3957.0700885291935, 4017.738846974996, 4039.1517781265675, 4064.146529228836, 5495.697736624444, 5571.582131340166, 5580.469855363734, 5599.80400685974, 5638.915416268759, 5910.083936989773, 5926.762929482772, 5931.911021334683, 5932.555058370639, 5937.643741375531, 5401.135818269058, 5517.69652669107, 5535.252740880011, 5590.5248053915875, 5591.608587398843, 5095.388553373545, 5101.846944591668, 5109.4379618241965, 5114.28400023997, 5154.201098829687, 6108.694565271719, 6154.0, 6155.045967874987, 6169.876602467925, 6176.382361763877, 5668.829935101953, 5826.126081087701, 5867.618604790675, 5931.317898441562, 5953.434423729739, 6158.199434073542, 6159.538034647509, 6172.043333283348, 6175.84560385994, 6178.876422471435, 5812.418758124154, 5815.5929084963645, 5819.388964158702, 5819.592628516132, 5849.239598852122, 5704.401037890962, 5761.164631128379, 5764.135379692912, 5794.565407594363, 5914.378990205966, 5664.122061080539, 5691.857703557444, 5692.089265717465, 5699.629524080921, 5704.0, 5692.544596432358, 5702.743376547983, 5703.486686198262, 5706.657600543981, 5709.571782116275, 5495.395506494203, 5561.4716601922755, 5582.134769110794, 5599.04816181242, 5658.179563963285, 5775.075987841925, 5831.067029275296, 5831.766729330949, 5835.67903765297, 5839.708014599338, 5459.044667183306, 5613.74738136793, 5660.037793575185, 5660.51885589713, 5664.745086471036], "value": 5408.674755555128, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1326270276747, 635.4535099814159, 640.1454058831462, 646.6766616691654, 649.7303618998116, 43744.562554374446, 44497.0, 44886.32670509941, 45282.32076518851, 48916.51083489164, 46465.0, 47248.76375618126, 47263.29105063427, 47270.29094563585, 47343.52656473434, 8032.959835200816, 8188.590570471482, 8192.344612431021, 8979.640814367418, 9115.042920493352, 8201.876971845428, 10396.324238924484, 10611.416372099531, 10613.73465663357, 10997.835032474519, 10769.515371808247, 10826.512806923707, 10827.07969822566, 10833.0, 10834.0, 7934.603269836485, 10442.738931526697, 10612.946935265312, 10652.680419587463, 10668.626598069108, 10281.280310378277, 10735.141188704885, 10748.462576871125, 10748.946255268751, 10754.139668826476, 42194.78902605498, 42647.57352426467, 42649.36025959613, 42742.145157096995, 42855.78572107151, 3480.3909315869623, 3484.163800687842, 3499.0902365384927, 3536.522569453117, 3544.61009288978, 30568.388632227452, 30823.845880770452, 30854.691453085405, 33887.0, 33917.49123763145, 4347.260965635818, 4443.400140980991, 4482.372467854503, 4494.16857881293, 4595.517470665599, 326134.0, 326574.0, 328256.0, 328289.9999999976, 328925.0, 35551.0, 36587.63412365896, 61898.38101618926, 63205.36794632087, 63242.0513692295, 38528.76183619856, 38530.22939541194, 38681.0, 38716.0, 38717.806410967765, 15701.214939252992, 15745.370185192693, 15786.289616967264, 15834.129122898352, 15834.52496425086, 11846.407679615984, 12061.457234424297, 12071.698207544881, 12584.18202816814, 12946.546870859474, 8654.826903461895, 8708.477491350539, 8730.781730456662, 8804.647814087493, 8841.16008979146, 3338.3490219407468, 3341.0, 3371.0, 3373.2578832656777, 3381.966180338214, 1071.3304184884448, 1099.2960910588556, 1100.834874768791, 1119.770447058351, 1196.2284326609288, 33482.3303533928, 33887.49168762471, 33889.32221355559, 34189.48715769265, 34249.0, 1184.6189159788714, 1194.5878671858368, 1198.5505435461703, 1245.9439325230387, 1271.2436100520176, 17354.566135846453, 17899.02296384277, 17907.121980464985, 18084.367047153286, 18098.21776636033, 154418.0, 154682.0, 155191.0, 155924.22037889966, 156496.0, 60941.39058609357, 60958.0, 61265.69367153225, 61353.38646613566, 61586.69206653938, 1310.1156719214491, 1410.3230449384148, 1419.6025112968384, 1433.2475450388422, 1459.3797636004656, 30610.693893060783, 34046.0, 34290.314193716484, 34607.480887787206, 34960.475592866635, 52386.21420678769, 56924.430755691916, 58481.0, 58867.0, 64603.353966459734, 516219.4189029031, 517730.0, 524608.0, 524960.0, 525827.0, 37300.440493393166, 38520.6147938517, 39658.40512392259, 45350.54649453463, 45818.541814581426, 46956.295655564514, 50368.496315037846, 50820.74589627028, 51646.48353516567, 52116.73941630419, 41216.38175427431, 42783.572164279205, 43302.78348608237, 43368.34947475727, 44463.33305000492, 41761.79119104385, 42217.155656887306, 42364.0, 42438.57561424346, 43297.0, 42160.36759448549, 42557.57442425536, 43858.342124867515, 43994.900127497065, 44041.77979110212, 36504.81747591245, 37281.81359093187, 37571.62428375681, 38344.23311533698, 38354.61645383511, 29170.854145729983, 29479.936404451484, 29570.556441653822, 29785.0, 29897.70102299036], "value": 19397.067463668252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.863026570966, 404.6095517825298, 408.3568379801812, 408.4057696052244, 421.13036579463403, 13619.863801361984, 18342.724859127105, 18860.339888103917, 20119.396418107463, 20119.899400502996, 17720.379786707468, 18191.0, 18391.632167356645, 19949.900250498762, 20101.195952161896, 5866.237389139416, 6018.7893423730175, 6027.578069535134, 6032.125341825433, 6060.969695151518, 5910.113482977545, 5963.970180149093, 5966.8806623867495, 5971.641701497902, 5976.641401515902, 4194.643455306287, 4732.0, 6588.769393071243, 6601.075849381066, 6707.832304192385, 5314.840554783363, 5703.828885133453, 6605.504587155959, 6646.833829154238, 6669.399754022137, 5426.891462170774, 5582.91625625616, 5613.129964855454, 5614.382417934024, 5623.522000629951, 14224.217668028254, 14469.638259043502, 14490.637734056627, 14495.71008579833, 14992.775108373275, 2257.24382331919, 2292.4727312718, 2416.371743346725, 2450.301664025762, 2523.570992931206, 10643.680689579325, 10889.782204355948, 12948.417321220568, 14039.64900877476, 14110.0, 1993.5016245938516, 1999.62007218628, 2068.7626805182385, 2100.306898723418, 2144.5603651251454, 69036.0, 81991.59004205001, 85758.0, 87081.56459217664, 87334.5633271836, 10887.074598659045, 11059.0, 11288.379139147426, 11464.770704585862, 11561.30632162073, 15804.288807003712, 15943.681126377407, 15969.201539922957, 16015.759763603555, 16044.117573533335, 8235.423520353517, 8415.831683366298, 8425.957870210732, 8616.870746938801, 8631.525266110424, 8291.8341633167, 8295.585220738938, 8302.667893284322, 8419.579021049045, 8421.536815475085, 4842.055799119138, 4863.489333619989, 4944.269505672985, 4978.4274808397495, 4990.90018199634, 1941.8155275248828, 1995.4013795861183, 2040.5306779440514, 2048.621005114059, 2054.085931760382, 988.3279370028306, 1016.4561959351711, 1064.0, 1105.6019832860163, 1147.1969621265148, 18932.24271029171, 19514.21943122259, 19643.705344419846, 19809.306674266332, 20011.099500522512, 1016.3850870223556, 1022.2384323678758, 1053.8629978102797, 1055.1137044882337, 1062.6918193723889, 10651.467426628638, 11135.0, 11350.432478376048, 11401.315921044765, 11435.59975400857, 475259.0, 479705.0, 491272.0, 493057.0, 493680.0, 73618.63190684012, 84276.0, 87792.0, 91113.44611048193, 93784.5932311016, 1043.7860238651058, 1045.8744950605976, 1090.9181811364022, 1112.404863398078, 1118.0887576625187, 16391.180440977663, 16783.916080420007, 16885.40901068457, 16959.0, 17171.399001034904, 40109.79945100256, 41443.1711365777, 41573.0, 42120.26218295801, 42984.57015429805, 51084.0, 51650.48349516457, 55368.44631553794, 57667.7116614431, 57892.71053644705, 8868.11318868108, 8945.910540894507, 9080.954595226982, 9126.0, 9395.436273823592, 12895.6471964362, 14017.929910350384, 14031.719365612427, 14061.507847225706, 14314.0, 12087.758244834878, 12377.0, 12419.503219871465, 12446.315452650191, 12474.251544907334, 12114.394280286127, 12148.0, 12226.572069977508, 12491.937540312603, 12527.18573292733, 12598.0, 12657.114002020138, 12692.873071269538, 12709.745805084032, 12818.807717884052, 8829.64681412762, 9070.45024367718, 9092.95386045682, 9147.131022552847, 9249.907500924905, 9447.244220462484, 11734.823977640172, 12453.75092498163, 12462.43919023628, 12497.125201235825], "value": 9385.68777677067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.3162950154428, 1581.8339074397188, 1592.992035039825, 1768.3280353465682, 1914.1386376130736, 8761.342899282547, 9055.683051093205, 9077.273818094545, 9398.201152902011, 9416.905830941689, 9119.817603647924, 9311.20854727349, 9311.906880931188, 9314.441133531993, 9319.58061887215, 2354.423166324253, 2381.285614315707, 2381.868997205153, 2383.0825132324094, 2384.2012925669833, 2393.652920326552, 2408.9638655420094, 2447.840890342131, 2456.5701002324613, 2457.348802567321, 2371.739108698042, 2392.126873691099, 2400.807935365175, 2437.890294936732, 2440.5362981033636, 2306.988465057664, 2320.373499155227, 2328.2782337475437, 2332.626779715246, 2349.048635302705, 2196.286206982737, 2249.2802303262797, 2252.3355610094895, 2258.3789457899043, 2260.480089579406, 7722.768316950501, 8463.95768021162, 9233.21517670992, 9293.488858112802, 9321.161095501437, 5497.835064948058, 5651.321841379061, 5656.434356564352, 5657.15142728594, 5659.0, 3496.7377446691344, 3624.800635965021, 3639.1266096137, 3643.6902863256655, 3692.4276737105524, 1108.695108845066, 1113.0872684398796, 1117.8323251512256, 1147.7761836441898, 1151.8502594662723, 13274.203547787163, 13284.601461956157, 13325.600231993056, 13441.395137218751, 13449.731005379936, 4720.763961801897, 4724.929126063112, 4794.113089078532, 4806.807727690853, 4899.0, 10237.334573252863, 10252.282340236261, 10274.126699230499, 10275.0, 10276.280660353703, 5450.890982180414, 5474.7262636868, 5477.726113694379, 5491.395946445888, 5492.5605951523785, 5070.467600901926, 5086.16078347076, 5177.068127737043, 5209.244659524347, 5241.711705856214, 3762.529683789526, 3823.6749876260274, 3847.499825022785, 3879.7866117363815, 3896.3960586109197, 1193.1267909382186, 1207.3480320626938, 1221.645722740413, 1228.5761412312916, 1240.7890658588062, 1008.5562352564848, 1013.5033833421718, 1015.3907655406845, 1038.382162613244, 1050.138886113395, 6224.751009959641, 6310.1481300024825, 6340.461060809883, 6408.423241908251, 6432.4532414744335, 489.1439980034939, 496.05253964926817, 496.98862814172986, 982.3860087445347, 1063.3194755356578, 4327.026419055687, 4392.670549708785, 4477.686561940698, 4481.75350355727, 4524.253498172765, 11623.244489108181, 11782.351970641697, 11846.229995050295, 11883.70290742721, 11900.40497975115, 11039.944800276107, 11584.536618535165, 11608.883911160949, 11793.174477786473, 11837.76324473523, 8664.653413863502, 8762.299016078698, 8792.516411597424, 8808.251298639687, 8853.114688531225, 6050.546209034252, 6193.659348735863, 6224.408681175281, 6257.4994000480765, 6272.874542509033, 10820.296680715728, 10820.5130769114, 10827.891721082688, 10923.672289831318, 10940.343579385262, 10986.560537578407, 11119.610813621484, 11177.497012634614, 11241.831372529583, 11311.604093856675, 8154.266116049584, 8163.877541836759, 8184.468009579597, 8300.958495207486, 8308.210719981593, 8916.465012099296, 9034.503102329172, 9051.95474022652, 9052.411593246417, 9059.773505662411, 7868.488548244346, 8073.555954422563, 8105.473144245605, 8192.508449493049, 8456.619452124545, 8072.273495385443, 8103.797405064921, 8117.0, 8236.176382361717, 8278.917210828056, 7430.368418684472, 7498.32515073646, 7569.5079819811535, 7579.772606821804, 7581.393488521016, 5452.6183167177915, 5458.645188062763, 5477.178423236546, 5499.257600223918, 5615.606907516435, 5629.26819513477, 5754.913676294943, 5851.1223316502865, 5883.0881213411985, 5906.70466476683], "value": 4820.569286795076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1571072319202, 346.16056064044693, 354.629412264184, 355.0, 355.1990261959281, 5290.1800220965815, 5406.0, 5429.972850135749, 5487.64330318529, 5514.172874068891, 5428.891422171554, 5429.239906413095, 5440.537554307879, 5448.918266226, 5460.645058071233, 4270.0, 4287.699861009715, 4292.699511034229, 4305.784710764465, 4315.633171180438, 4065.6544193743566, 4125.9174816503655, 4298.0, 4316.633086187678, 4350.73895566267, 4219.409282700424, 4238.258304796664, 4242.469691288589, 4245.9575404246025, 4245.9787701061605, 4205.201011807762, 4215.873523794291, 4223.957760422418, 4226.661867050644, 4228.725132866354, 3734.589195188527, 3805.5052843130493, 3816.0, 3820.4078367853026, 3827.0815004399024, 5206.526899722601, 5216.217567364888, 5223.582113430954, 5228.346456692913, 5245.0, 4886.0, 4887.242477416006, 4902.240152776325, 4902.803887844482, 4917.50824917509, 5584.106542953149, 5673.375928647845, 5691.260136182311, 5697.743601537899, 5717.341970828455, 4189.324270291877, 4196.412502249687, 4211.768352740598, 4219.662427005832, 4221.282381995068, 5690.687012214326, 5801.070459418009, 5911.940880591225, 5916.940830591682, 5961.195238642771, 4092.529359123679, 4234.491860976703, 4236.35227982511, 4254.851080212177, 4304.428883457515, 4287.528371879091, 4297.710686794012, 4300.247456695066, 4300.247456695129, 4342.413774140514, 4835.903281934342, 4848.109237397418, 4853.538913803183, 4871.8294859679745, 4886.0, 5391.299131113009, 5587.525060369833, 5686.3744988051285, 5723.54211663066, 5749.195112684228, 1371.5611004478671, 1418.9003522270323, 1442.8268607766925, 1457.9416823326949, 1467.8091848059898, 913.3150137396952, 926.7358802741321, 936.765808547863, 936.9625214991461, 946.1673727120228, 4809.268663281216, 4853.611711063107, 4864.197407427735, 4866.301610775765, 4891.584215341664, 5067.569256613156, 5080.237964305384, 5113.287048838681, 5125.820596279113, 5217.895642087137, 4834.806607735722, 4850.442199147073, 4870.707757534559, 4880.951190488121, 5123.205903085028, 3079.122450101755, 3090.3046814466566, 3121.484954982448, 3124.078396872928, 3128.8122712637314, 5997.83042306746, 6022.488088512526, 6077.270727512639, 6079.0, 6090.421409966046, 5651.886962260732, 5943.524518038633, 5945.464908158287, 5950.7917222896995, 5980.491658209101, 6076.544259180668, 6086.786962456381, 6103.511719062464, 6109.969450152721, 6119.785807496716, 5626.690532020614, 5892.587518873637, 5902.350741418355, 5913.438223368773, 5925.703714814328, 5782.710864456844, 5791.362950075404, 5792.609773654377, 5819.621724587888, 5824.3593204748295, 6054.515638748801, 6071.574989750675, 6101.84745381369, 6106.725197366218, 6116.186554185125, 3962.3660214365564, 4186.937195942124, 4200.810963506588, 4206.242876282298, 4213.810378533035, 5654.406287339934, 5735.655860648374, 5761.366249712612, 5770.855728606818, 5808.867270882306, 5564.221009058816, 5668.574856885833, 5673.3759286477625, 5704.231688176513, 5781.306243250837, 5607.383187849415, 5616.21373007771, 5670.5180059695385, 5686.829395118153, 5688.0, 5358.196270559447, 5592.51798273466, 5602.187682785891, 5611.831645050655, 5625.887482250414, 5742.339630942495, 5752.533104058438, 5766.0, 5783.7397317119985, 5788.594798364074, 5419.376771671151, 5630.634008789416, 5662.57530685192, 5675.7445914933105, 5679.858003549944], "value": 4313.7364517367305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.2412771675332, 806.3750593290199, 815.2228142649022, 841.1420351241734, 841.2134654098419, 14737.778933315996, 15266.69466610667, 15357.539273821776, 15362.846371536309, 15387.384504619817, 12051.0, 14075.436982520712, 14103.0, 14103.365348559313, 14121.082129661565, 817.9713710020136, 842.3513894301384, 844.7592436155696, 845.9788505287386, 848.088305072047, 834.3908946469081, 835.2566216067675, 838.2832678060262, 841.1252297610508, 841.4446465332851, 730.1749023603321, 854.7008547008528, 889.1997202517754, 889.4174315823146, 890.3278025091047, 865.3207232322628, 867.9913200867974, 868.3140319147866, 868.8522951098329, 871.4945331707626, 631.2803404119308, 631.6241836107555, 631.6399652198248, 631.6967855429419, 631.9399657032575, 13613.11514751538, 13615.591532254048, 13656.112352697042, 13691.794623080661, 13694.383752731152, 13553.864461355359, 13789.379477923518, 13792.793108103386, 13829.0, 13931.58205253844, 12571.0, 12743.107982441234, 12817.743645127046, 12957.805632915513, 12994.610161695164, 4479.283314669669, 4486.237339652267, 4499.865004049884, 4505.256632655608, 4602.677812553089, 59840.700796496174, 59884.0, 60030.69984650049, 60118.0, 60766.08850867241, 11268.323900565993, 11268.492917818554, 11440.656780296604, 11486.42567871603, 11521.711957201138, 20162.092705828272, 20172.899135504227, 20201.797982020285, 20237.595248094956, 20918.267860624805, 8161.387895907831, 8202.343812494986, 8230.83538329242, 8258.050324212672, 8365.456245344034, 4653.60444362233, 4771.498992605726, 4813.711177329302, 4881.292212629149, 4888.486708895586, 3532.699720523733, 3564.3049605326714, 3630.473581330745, 3636.30910127075, 3638.235970446236, 648.3905129178557, 649.4804156674642, 656.9868602628017, 659.7394029358377, 671.2280876991401, 649.4544582550681, 706.2972342519226, 707.9787606371817, 713.3080911515822, 713.3437237741291, 8731.956340218258, 8996.775080623036, 9034.45793252407, 9170.724878253663, 9264.490453025148, 687.5118665747375, 690.1407747354576, 696.9303069692991, 708.0618180910211, 721.2246834652769, 4136.4415803866095, 4361.258586040381, 4391.538888416734, 4395.978020109879, 4431.224535706238, 71185.88141185943, 72138.63930680418, 74196.0, 74417.0, 74816.25183748093, 65296.673516632116, 65854.34145658578, 65939.34060659428, 66255.66872165704, 67485.0, 59900.0, 60050.0, 60893.39106608966, 60970.39029609647, 61454.0, 8102.0, 8143.470674406145, 8180.8363832721825, 8400.663973441238, 9137.177654011171, 34644.65355346515, 35741.46387804237, 36667.26665466622, 37280.0, 37465.43801843029, 48953.0, 50025.749871251865, 50721.74639126781, 50928.490715092375, 51112.0, 12695.301758403377, 12812.807807883075, 13107.410166542719, 13173.143745656502, 13349.199048057148, 13011.21932684004, 14103.506377276746, 14911.552653420415, 15033.849661503682, 15342.539723808304, 13143.211407315592, 13149.276789776271, 13697.08859687998, 13944.651383715489, 14124.223167725462, 13782.517611883535, 13922.0, 14098.36557354942, 14270.571882843531, 14890.77663835065, 12120.575779847662, 12815.16701414405, 12896.29070401137, 13301.401436935168, 13415.396307166397, 11277.492512837107, 11494.827577586175, 11542.711432213926, 11608.593699220486, 11848.229865058744, 11262.817240644585, 11457.770844582896, 11497.0, 11516.884831151916, 11652.53389864396], "value": 7097.057589646342, "unit": "score"}], "name": "dromaeo_css", "value": 7250.937171784226, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 111.0, 109.0, 109.0, 110.0, 108.0, 110.0, 110.0, 108.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 148.0, 217.0, 127.0, 157.0, 150.0, 126.0, 177.0, 126.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 146.0, 74.0, 75.0, 76.0, 76.0, 139.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 94.0, 92.0, 94.0, 119.0, 92.0, 92.0, 127.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 111.0, 55.0, 55.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 86.0, 85.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 121.0, 128.0, 127.0, 123.0, 125.0, 126.0, 199.0, 122.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 169.0, 158.0, 167.0, 163.0, 168.0, 160.0, 159.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 64.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1533.1, "alertThreshold": 2.0}]} 17:37:20 INFO - Return code: 0 17:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:20 ERROR - # TBPL SUCCESS # 17:37:20 INFO - Running post-action listener: _resource_record_post_action 17:37:20 INFO - ##### 17:37:20 INFO - ##### Finished run-tests step (success) 17:37:20 INFO - ##### 17:37:20 INFO - Running post-run listener: _resource_record_post_run 17:37:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 537444352; Read time: 140; Write time: 434864 17:37:20 INFO - TinderboxPrint: CPU usage
13.1% 17:37:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 140 17:37:20 INFO - TinderboxPrint: I/O write bytes / time
537,444,352 / 434,864 17:37:20 INFO - TinderboxPrint: CPU idle
8,267.2 (86.9%) 17:37:20 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 17:37:20 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 238886912; Read time: 0; Write time: 213444 17:37:20 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292397056; Read time: 140; Write time: 220836 17:37:20 INFO - Running post-run listener: _upload_blobber_files 17:37:20 INFO - Blob upload gear active. 17:37:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:20 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 17:37:20 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'] 17:37:20 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 17:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:25 INFO - (blobuploader) - INFO - Done attempting. 17:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:26 INFO - (blobuploader) - INFO - Done attempting. 17:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:27 INFO - (blobuploader) - INFO - Done attempting. 17:37:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:27 INFO - Return code: 0 17:37:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/545f4d278dae6d6d6235868047f73f39da1fd71454e8771c2cf4c0663b79fba065618dabdbd1a2a70a8584ee9a975fee1325e2d8004f64e8e739572e32855d06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8745421441c9697d37dd3db084d1fc768464f47a8f4ad3d99170c829e4eb7f29ca7cb4ff2a5ccfa1d9691ebddf30f76267adc37127a7e3324fd2e249c6c7fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac5b5d38315193c628740c4e06715a9f1bb48b2f5249ef2c8dc9b3b44ea579bc77c2b4cb66e83523d861df0fffadbd468e52c8813c95640efe6a5a9cb541cbd"} 17:37:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:27 INFO - Contents: 17:37:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/545f4d278dae6d6d6235868047f73f39da1fd71454e8771c2cf4c0663b79fba065618dabdbd1a2a70a8584ee9a975fee1325e2d8004f64e8e739572e32855d06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8745421441c9697d37dd3db084d1fc768464f47a8f4ad3d99170c829e4eb7f29ca7cb4ff2a5ccfa1d9691ebddf30f76267adc37127a7e3324fd2e249c6c7fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac5b5d38315193c628740c4e06715a9f1bb48b2f5249ef2c8dc9b3b44ea579bc77c2b4cb66e83523d861df0fffadbd468e52c8813c95640efe6a5a9cb541cbd"} 17:37:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:27 INFO - Copying logs to upload dir... 17:37:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.333243 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-13 17:37:26.432617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 17:37:26.436072) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 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/545f4d278dae6d6d6235868047f73f39da1fd71454e8771c2cf4c0663b79fba065618dabdbd1a2a70a8584ee9a975fee1325e2d8004f64e8e739572e32855d06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8745421441c9697d37dd3db084d1fc768464f47a8f4ad3d99170c829e4eb7f29ca7cb4ff2a5ccfa1d9691ebddf30f76267adc37127a7e3324fd2e249c6c7fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac5b5d38315193c628740c4e06715a9f1bb48b2f5249ef2c8dc9b3b44ea579bc77c2b4cb66e83523d861df0fffadbd468e52c8813c95640efe6a5a9cb541cbd"} build_url:https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/KLiuJf4jQe2Y8SO7JDIsng/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/545f4d278dae6d6d6235868047f73f39da1fd71454e8771c2cf4c0663b79fba065618dabdbd1a2a70a8584ee9a975fee1325e2d8004f64e8e739572e32855d06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8745421441c9697d37dd3db084d1fc768464f47a8f4ad3d99170c829e4eb7f29ca7cb4ff2a5ccfa1d9691ebddf30f76267adc37127a7e3324fd2e249c6c7fb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ac5b5d38315193c628740c4e06715a9f1bb48b2f5249ef2c8dc9b3b44ea579bc77c2b4cb66e83523d861df0fffadbd468e52c8813c95640efe6a5a9cb541cbd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 17:37:26.466718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:37:26.467238) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463184709.643543-1720902034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 17:37:26.559242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 17:37:26.559733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 17:37:26.560168) ========= ========= Total master_lag: 0.17 =========