builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1463689380.79 results: success (0) buildid: 20160519083055 builduid: ad837d37590f4ce1a57ed2d36a7dea65 revision: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:00.791472) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:00.792142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:00.792556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:00.811109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:00.811515) ========= 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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 13:23:00-- 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% 217M=0s 2016-05-19 13:23:01 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:01.023001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:01.023348) ========= 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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:01.073699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 13:23:01.074109) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebd649229181d40d9f5ae41ea4d2109c8f782fe8 --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 ebd649229181d40d9f5ae41ea4d2109c8f782fe8 --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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 13:23:01,162 truncating revision to first 12 chars 2016-05-19 13:23:01,162 Setting DEBUG logging. 2016-05-19 13:23:01,162 attempt 1/10 2016-05-19 13:23:01,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebd649229181?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 13:23:01,998 unpacking tar archive at: fx-team-ebd649229181/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 13:23:02.190035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:02.190675) ========= script_repo_revision: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:02.191337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:02.194875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 13:23:02.205839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-19 13:23:02.206217) ========= /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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:23:02 INFO - MultiFileLogger online at 20160519 13:23:02 in /builds/slave/test 13:23:02 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 13:23:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:23:02 INFO - {'append_to_log': False, 13:23:02 INFO - 'base_work_dir': '/builds/slave/test', 13:23:02 INFO - 'blob_upload_branch': 'Fx-Team', 13:23:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:23:02 INFO - 'branch': 'Fx-Team', 13:23:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:23:02 INFO - 'config_files': ('talos/linux_config.py',), 13:23:02 INFO - 'default_actions': ('clobber', 13:23:02 INFO - 'read-buildbot-config', 13:23:02 INFO - 'download-and-extract', 13:23:02 INFO - 'populate-webroot', 13:23:02 INFO - 'create-virtualenv', 13:23:02 INFO - 'install', 13:23:02 INFO - 'run-tests'), 13:23:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:23:02 INFO - 'download_minidump_stackwalk': True, 13:23:02 INFO - 'download_symbols': 'ondemand', 13:23:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:23:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:23:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:23:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:23:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:23:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:23:02 INFO - 'installer_path': 'installer.exe', 13:23:02 INFO - 'log_level': 'info', 13:23:02 INFO - 'log_name': 'talos', 13:23:02 INFO - 'log_to_console': True, 13:23:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:23:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:23:02 INFO - 'opt_config_files': (), 13:23:02 INFO - 'pip_index': False, 13:23:02 INFO - 'sps_profile': False, 13:23:02 INFO - 'sps_profile_interval': 0, 13:23:02 INFO - 'suite': 'dromaeojs', 13:23:02 INFO - 'system_bits': '32', 13:23:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:23:02 INFO - 'title': 'talos-linux64-ix-053', 13:23:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:23:02 INFO - 'use_talos_json': True, 13:23:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:23:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:23:02 INFO - 'work_dir': 'build'} 13:23:02 INFO - ##### 13:23:02 INFO - ##### Running clobber step. 13:23:02 INFO - ##### 13:23:02 INFO - Running pre-action listener: _resource_record_pre_action 13:23:02 INFO - Running main action method: clobber 13:23:02 INFO - rmtree: /builds/slave/test/build 13:23:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:23:02 INFO - Running post-action listener: _resource_record_post_action 13:23:02 INFO - ##### 13:23:02 INFO - ##### Finished clobber step (success) 13:23:02 INFO - ##### 13:23:02 INFO - ##### 13:23:02 INFO - ##### Running read-buildbot-config step. 13:23:02 INFO - ##### 13:23:02 INFO - Running pre-action listener: _resource_record_pre_action 13:23:02 INFO - Running main action method: read_buildbot_config 13:23:02 INFO - Using buildbot properties: 13:23:02 INFO - { 13:23:02 INFO - "project": "", 13:23:02 INFO - "product": "firefox", 13:23:02 INFO - "script_repo_revision": "production", 13:23:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:23:02 INFO - "repository": "", 13:23:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:23:02 INFO - "buildid": "20160519083055", 13:23:02 INFO - "pgo_build": "True", 13:23:02 INFO - "basedir": "/builds/slave/test", 13:23:02 INFO - "buildnumber": 701, 13:23:02 INFO - "slavename": "talos-linux64-ix-053", 13:23:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:23:02 INFO - "platform": "ubuntu64_hw", 13:23:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:23:02 INFO - "branch": "fx-team", 13:23:02 INFO - "repo_path": "integration/fx-team", 13:23:02 INFO - "revision": "ebd649229181d40d9f5ae41ea4d2109c8f782fe8", 13:23:02 INFO - "stage_platform": "linux64-pgo", 13:23:02 INFO - "builduid": "ad837d37590f4ce1a57ed2d36a7dea65", 13:23:02 INFO - "slavebuilddir": "test" 13:23:02 INFO - } 13:23:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:23:02 INFO - Running post-action listener: _resource_record_post_action 13:23:02 INFO - ##### 13:23:02 INFO - ##### Finished read-buildbot-config step (success) 13:23:02 INFO - ##### 13:23:02 INFO - ##### 13:23:02 INFO - ##### Running download-and-extract step. 13:23:02 INFO - ##### 13:23:02 INFO - Running pre-action listener: _resource_record_pre_action 13:23:02 INFO - Running main action method: download_and_extract 13:23:02 INFO - mkdir: /builds/slave/test/build/tests 13:23:02 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')]} 13:23:02 INFO - https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:03 INFO - Downloaded 1361 bytes. 13:23:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:23:03 INFO - Using the following test package requirements: 13:23:03 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:23:03 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:23:03 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:23:03 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'jsshell-linux-x86_64.zip'], 13:23:03 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:23:03 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:23:03 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:23:03 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:23:03 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:23:03 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:23:03 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:23:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:03 INFO - https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:08 INFO - Downloaded 24386158 bytes. 13:23:08 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'] 13:23:08 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 13:23:09 INFO - Return code: 0 13:23:09 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 13:23:09 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')]} 13:23:09 INFO - https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:12 INFO - Downloaded 24386158 bytes. 13:23:12 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'] 13:23:12 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 13:23:13 INFO - Return code: 0 13:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:13 INFO - https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:16 INFO - Downloaded 10840194 bytes. 13:23:16 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'] 13:23:16 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 13:23:16 INFO - Return code: 0 13:23:16 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')]} 13:23:16 INFO - https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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 13:23:20 INFO - Downloaded 58437462 bytes. 13:23:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:23:20 INFO - mkdir: /builds/slave/test/properties 13:23:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:23:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:23:20 INFO - Contents: 13:23:20 INFO - build_url:https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:23:22 INFO - Running post-action listener: _resource_record_post_action 13:23:22 INFO - Running post-action listener: set_extra_try_arguments 13:23:22 INFO - ##### 13:23:22 INFO - ##### Finished download-and-extract step (success) 13:23:22 INFO - ##### 13:23:22 INFO - ##### 13:23:22 INFO - ##### Running populate-webroot step. 13:23:22 INFO - ##### 13:23:22 INFO - Running pre-action listener: _resource_record_pre_action 13:23:22 INFO - Running main action method: populate_webroot 13:23:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:23:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:23:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:23:22 INFO - '--tppagecycles', 13:23:22 INFO - '7'], 13:23:22 INFO - 'tests': ['tsvgm']}}, 13:23:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:23:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:23:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:23:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:23:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['damp', 'tps']}, 13:23:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'tests': ['damp', 'tps']}, 13:23:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['dromaeo_dom']}, 13:23:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:23:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['a11yr', 13:23:22 INFO - 'ts_paint', 13:23:22 INFO - 'tpaint', 13:23:22 INFO - 'sessionrestore', 13:23:22 INFO - 'sessionrestore_no_auto_restore', 13:23:22 INFO - 'tabpaint']}, 13:23:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['tsvgx', 13:23:22 INFO - 'tsvgr_opacity', 13:23:22 INFO - 'tart', 13:23:22 INFO - 'tscrollx', 13:23:22 INFO - 'cart']}, 13:23:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:23:22 INFO - 'tsvgr_opacity', 13:23:22 INFO - 'tart', 13:23:22 INFO - 'tscrollx', 13:23:22 INFO - 'cart']}, 13:23:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'talos_options': ['--disable-e10s'], 13:23:22 INFO - 'tests': ['tp5o']}, 13:23:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'tests': ['tp5o']}, 13:23:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'talos_options': ['--disable-e10s', 13:23:22 INFO - '--xperf_path', 13:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:22 INFO - 'tests': ['tp5n']}, 13:23:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:22 INFO - 'talos_options': ['--xperf_path', 13:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:22 INFO - 'tests': ['tp5n']}}, 13:23:22 INFO - 'talos.zip': {'path': '', 13:23:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:23:22 INFO - Running post-action listener: _resource_record_post_action 13:23:22 INFO - ##### 13:23:22 INFO - ##### Finished populate-webroot step (success) 13:23:22 INFO - ##### 13:23:22 INFO - ##### 13:23:22 INFO - ##### Running create-virtualenv step. 13:23:22 INFO - ##### 13:23:22 INFO - Running pre-action listener: _resource_record_pre_action 13:23:22 INFO - Running main action method: create_virtualenv 13:23:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:23:22 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 13:23:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:23:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:23:22 INFO - Using real prefix '/usr' 13:23:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:23:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:23:24 INFO - Installing pip.................done. 13:23:24 INFO - Return code: 0 13:23:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23: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', 'pip>=1.5'] in /builds/slave/test/build 13:23: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 pip>=1.5 13:23:24 INFO - Using env: {'DISPLAY': ':0', 13:23:24 INFO - 'HOME': '/home/cltbld', 13:23:24 INFO - 'LANG': 'en_US.UTF-8', 13:23:24 INFO - 'LANGUAGE': 'en_US:en', 13:23:24 INFO - 'LOGNAME': 'cltbld', 13:23:24 INFO - 'MAIL': '/var/mail/cltbld', 13:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:24 INFO - 'MOZ_NO_REMOTE': '1', 13:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:24 INFO - 'NO_EM_RESTART': '1', 13:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:24 INFO - 'PWD': '/builds/slave/test', 13:23:24 INFO - 'SHELL': '/bin/bash', 13:23:24 INFO - 'SHLVL': '1', 13:23:24 INFO - 'TERM': 'linux', 13:23:24 INFO - 'TMOUT': '86400', 13:23:24 INFO - 'USER': 'cltbld', 13:23:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:24 INFO - '_': '/tools/buildbot/bin/python'} 13:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:24 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 13:23:24 INFO - Cleaning up... 13:23:24 INFO - Return code: 0 13:23:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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', '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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:23: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 psutil>=3.1.1 13:23:24 INFO - Using env: {'DISPLAY': ':0', 13:23:24 INFO - 'HOME': '/home/cltbld', 13:23:24 INFO - 'LANG': 'en_US.UTF-8', 13:23:24 INFO - 'LANGUAGE': 'en_US:en', 13:23:24 INFO - 'LOGNAME': 'cltbld', 13:23:24 INFO - 'MAIL': '/var/mail/cltbld', 13:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:24 INFO - 'MOZ_NO_REMOTE': '1', 13:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:24 INFO - 'NO_EM_RESTART': '1', 13:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:24 INFO - 'PWD': '/builds/slave/test', 13:23:24 INFO - 'SHELL': '/bin/bash', 13:23:24 INFO - 'SHLVL': '1', 13:23:24 INFO - 'TERM': 'linux', 13:23:24 INFO - 'TMOUT': '86400', 13:23:24 INFO - 'USER': 'cltbld', 13:23:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:24 INFO - '_': '/tools/buildbot/bin/python'} 13:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:25 INFO - Downloading/unpacking psutil>=3.1.1 13:23:25 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 13:23:25 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 13:23:25 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 13:23:25 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 13:23:25 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 13:23:25 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 13:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:27 INFO - Installing collected packages: psutil 13:23:27 INFO - Running setup.py install for psutil 13:23:27 INFO - building 'psutil._psutil_linux' extension 13:23:27 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 13:23:27 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 13:23:27 INFO - building 'psutil._psutil_posix' extension 13:23:27 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 13:23:27 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 13:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:27 INFO - Successfully installed psutil 13:23:27 INFO - Cleaning up... 13:23:27 INFO - Return code: 0 13:23:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23:27 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')]} 13:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 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')]} 13:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:23:27 INFO - Using env: {'DISPLAY': ':0', 13:23:27 INFO - 'HOME': '/home/cltbld', 13:23:27 INFO - 'LANG': 'en_US.UTF-8', 13:23:27 INFO - 'LANGUAGE': 'en_US:en', 13:23:27 INFO - 'LOGNAME': 'cltbld', 13:23:27 INFO - 'MAIL': '/var/mail/cltbld', 13:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:27 INFO - 'MOZ_NO_REMOTE': '1', 13:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:27 INFO - 'NO_EM_RESTART': '1', 13:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:27 INFO - 'PWD': '/builds/slave/test', 13:23:27 INFO - 'SHELL': '/bin/bash', 13:23:27 INFO - 'SHLVL': '1', 13:23:27 INFO - 'TERM': 'linux', 13:23:27 INFO - 'TMOUT': '86400', 13:23:27 INFO - 'USER': 'cltbld', 13:23:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:27 INFO - '_': '/tools/buildbot/bin/python'} 13:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:29 INFO - Installing collected packages: mozsystemmonitor 13:23:29 INFO - Running setup.py install for mozsystemmonitor 13:23:29 INFO - Successfully installed mozsystemmonitor 13:23:29 INFO - Cleaning up... 13:23:29 INFO - Return code: 0 13:23:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:29 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')]} 13:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:29 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')]} 13:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:29 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:29 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 13:23:29 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 13:23:29 INFO - Using env: {'DISPLAY': ':0', 13:23:29 INFO - 'HOME': '/home/cltbld', 13:23:29 INFO - 'LANG': 'en_US.UTF-8', 13:23:29 INFO - 'LANGUAGE': 'en_US:en', 13:23:29 INFO - 'LOGNAME': 'cltbld', 13:23:29 INFO - 'MAIL': '/var/mail/cltbld', 13:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:29 INFO - 'MOZ_NO_REMOTE': '1', 13:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:29 INFO - 'NO_EM_RESTART': '1', 13:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:29 INFO - 'PWD': '/builds/slave/test', 13:23:29 INFO - 'SHELL': '/bin/bash', 13:23:29 INFO - 'SHLVL': '1', 13:23:29 INFO - 'TERM': 'linux', 13:23:29 INFO - 'TMOUT': '86400', 13:23:29 INFO - 'USER': 'cltbld', 13:23:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:29 INFO - '_': '/tools/buildbot/bin/python'} 13:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:32 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 13:23:33 INFO - Downloading docopt-0.6.1.tar.gz 13:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:33 INFO - Running setup.py install for blobuploader 13:23:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:33 INFO - Running setup.py install for requests 13:23:33 INFO - Running setup.py install for docopt 13:23:33 INFO - Successfully installed blobuploader requests docopt 13:23:33 INFO - Cleaning up... 13:23:33 INFO - Return code: 0 13:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:33 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:33 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 13:23:33 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 13:23:33 INFO - Using env: {'DISPLAY': ':0', 13:23:33 INFO - 'HOME': '/home/cltbld', 13:23:33 INFO - 'LANG': 'en_US.UTF-8', 13:23:33 INFO - 'LANGUAGE': 'en_US:en', 13:23:33 INFO - 'LOGNAME': 'cltbld', 13:23:33 INFO - 'MAIL': '/var/mail/cltbld', 13:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:33 INFO - 'MOZ_NO_REMOTE': '1', 13:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:33 INFO - 'NO_EM_RESTART': '1', 13:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:33 INFO - 'PWD': '/builds/slave/test', 13:23:33 INFO - 'SHELL': '/bin/bash', 13:23:33 INFO - 'SHLVL': '1', 13:23:33 INFO - 'TERM': 'linux', 13:23:33 INFO - 'TMOUT': '86400', 13:23:33 INFO - 'USER': 'cltbld', 13:23:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:33 INFO - '_': '/tools/buildbot/bin/python'} 13:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:33 INFO - Running setup.py (path:/tmp/pip-yhts3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:34 INFO - Running setup.py (path:/tmp/pip-GIClvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:34 INFO - Running setup.py (path:/tmp/pip-i7MRFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:34 INFO - Running setup.py (path:/tmp/pip-JT9sCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:34 INFO - Running setup.py (path:/tmp/pip-hmb5CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:34 INFO - Running setup.py (path:/tmp/pip-SZ5Xha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:34 INFO - Running setup.py (path:/tmp/pip-L32BTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:34 INFO - Running setup.py (path:/tmp/pip-pLL16r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:34 INFO - Running setup.py (path:/tmp/pip-FLkpT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:34 INFO - Running setup.py (path:/tmp/pip-YywsGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:34 INFO - Running setup.py (path:/tmp/pip-oWTcCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:34 INFO - Running setup.py (path:/tmp/pip-yUn1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:34 INFO - Running setup.py (path:/tmp/pip-WXJLm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:34 INFO - Running setup.py (path:/tmp/pip-LgBa5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:34 INFO - Running setup.py (path:/tmp/pip-3ftz2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:35 INFO - Running setup.py (path:/tmp/pip-UiAFrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:35 INFO - Running setup.py (path:/tmp/pip-zH_5lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:35 INFO - Running setup.py install for manifestparser 13:23:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Running setup.py install for mozcrash 13:23:35 INFO - Running setup.py install for mozdebug 13:23:35 INFO - Running setup.py install for mozdevice 13:23:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Running setup.py install for mozfile 13:23:35 INFO - Running setup.py install for mozhttpd 13:23:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Running setup.py install for mozinfo 13:23:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Running setup.py install for mozInstall 13:23:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:35 INFO - Running setup.py install for mozleak 13:23:36 INFO - Running setup.py install for mozlog 13:23:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Running setup.py install for moznetwork 13:23:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Running setup.py install for mozprocess 13:23:36 INFO - Running setup.py install for mozprofile 13:23:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Running setup.py install for mozrunner 13:23:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Running setup.py install for mozscreenshot 13:23:36 INFO - Running setup.py install for moztest 13:23:36 INFO - Running setup.py install for mozversion 13:23:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:36 INFO - Cleaning up... 13:23:36 INFO - Return code: 0 13:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:36 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:36 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 13:23:36 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 13:23:36 INFO - Using env: {'DISPLAY': ':0', 13:23:36 INFO - 'HOME': '/home/cltbld', 13:23:36 INFO - 'LANG': 'en_US.UTF-8', 13:23:36 INFO - 'LANGUAGE': 'en_US:en', 13:23:36 INFO - 'LOGNAME': 'cltbld', 13:23:36 INFO - 'MAIL': '/var/mail/cltbld', 13:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:36 INFO - 'MOZ_NO_REMOTE': '1', 13:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:36 INFO - 'NO_EM_RESTART': '1', 13:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:36 INFO - 'PWD': '/builds/slave/test', 13:23:36 INFO - 'SHELL': '/bin/bash', 13:23:36 INFO - 'SHLVL': '1', 13:23:36 INFO - 'TERM': 'linux', 13:23:36 INFO - 'TMOUT': '86400', 13:23:36 INFO - 'USER': 'cltbld', 13:23:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:36 INFO - '_': '/tools/buildbot/bin/python'} 13:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:37 INFO - Running setup.py (path:/tmp/pip-P8Elgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:37 INFO - Running setup.py (path:/tmp/pip-BjL8IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:37 INFO - Running setup.py (path:/tmp/pip-NaAitB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:37 INFO - Running setup.py (path:/tmp/pip-LDKsCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:37 INFO - Running setup.py (path:/tmp/pip-vLsFrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:37 INFO - Running setup.py (path:/tmp/pip-AlciCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:37 INFO - Running setup.py (path:/tmp/pip-X3E5ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:37 INFO - Running setup.py (path:/tmp/pip-InEy3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:37 INFO - Running setup.py (path:/tmp/pip-zUUTV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:37 INFO - Running setup.py (path:/tmp/pip-ewvaCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:37 INFO - Running setup.py (path:/tmp/pip-8yZBVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:37 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)) 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:37 INFO - Running setup.py (path:/tmp/pip-3Uu6Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:38 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)) 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:38 INFO - Running setup.py (path:/tmp/pip-TKbjZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:38 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)) 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:38 INFO - Running setup.py (path:/tmp/pip-MQfiya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:38 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)) 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:38 INFO - Running setup.py (path:/tmp/pip-AdjMYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:38 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)) 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:38 INFO - Running setup.py (path:/tmp/pip-d4Kmcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:38 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)) 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:38 INFO - Running setup.py (path:/tmp/pip-fuVRNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:38 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)) 13:23:38 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)) 13:23:38 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)) 13:23:38 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)) 13:23:38 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)) 13:23:38 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)) 13:23:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:38 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 13:23:38 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 13:23:38 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 13:23:38 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 13:23:38 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 13:23:38 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 13:23:40 INFO - Downloading blessings-1.6.tar.gz 13:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:40 INFO - Installing collected packages: blessings 13:23:40 INFO - Running setup.py install for blessings 13:23:40 INFO - Successfully installed blessings 13:23:40 INFO - Cleaning up... 13:23:40 INFO - Return code: 0 13:23:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:40 INFO - Reading from file tmpfile_stdout 13:23:40 INFO - Current package versions: 13:23:40 INFO - argparse == 1.2.1 13:23:40 INFO - blessings == 1.6 13:23:40 INFO - blobuploader == 1.2.4 13:23:40 INFO - docopt == 0.6.1 13:23:40 INFO - manifestparser == 1.1 13:23:40 INFO - mozInstall == 1.12 13:23:40 INFO - mozcrash == 0.17 13:23:40 INFO - mozdebug == 0.1 13:23:40 INFO - mozdevice == 0.48 13:23:40 INFO - mozfile == 1.2 13:23:40 INFO - mozhttpd == 0.7 13:23:40 INFO - mozinfo == 0.9 13:23:40 INFO - mozleak == 0.1 13:23:40 INFO - mozlog == 3.2 13:23:40 INFO - moznetwork == 0.27 13:23:40 INFO - mozprocess == 0.22 13:23:40 INFO - mozprofile == 0.28 13:23:40 INFO - mozrunner == 6.11 13:23:40 INFO - mozscreenshot == 0.1 13:23:40 INFO - mozsystemmonitor == 0.3 13:23:40 INFO - moztest == 0.7 13:23:40 INFO - mozversion == 1.4 13:23:40 INFO - psutil == 3.1.1 13:23:40 INFO - requests == 1.2.3 13:23:40 INFO - wsgiref == 0.1.2 13:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:40 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')]} 13:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 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')]} 13:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:40 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 13:23:40 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 13:23:40 INFO - Using env: {'DISPLAY': ':0', 13:23:40 INFO - 'HOME': '/home/cltbld', 13:23:40 INFO - 'LANG': 'en_US.UTF-8', 13:23:40 INFO - 'LANGUAGE': 'en_US:en', 13:23:40 INFO - 'LOGNAME': 'cltbld', 13:23:40 INFO - 'MAIL': '/var/mail/cltbld', 13:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:40 INFO - 'MOZ_NO_REMOTE': '1', 13:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:40 INFO - 'NO_EM_RESTART': '1', 13:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:40 INFO - 'PWD': '/builds/slave/test', 13:23:40 INFO - 'SHELL': '/bin/bash', 13:23:40 INFO - 'SHLVL': '1', 13:23:40 INFO - 'TERM': 'linux', 13:23:40 INFO - 'TMOUT': '86400', 13:23:40 INFO - 'USER': 'cltbld', 13:23:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:40 INFO - '_': '/tools/buildbot/bin/python'} 13:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 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)) 13:23:40 INFO - Cleaning up... 13:23:40 INFO - Return code: 0 13:23:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:40 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')]} 13:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 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')]} 13:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:40 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 13:23:40 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 13:23:40 INFO - Using env: {'DISPLAY': ':0', 13:23:40 INFO - 'HOME': '/home/cltbld', 13:23:40 INFO - 'LANG': 'en_US.UTF-8', 13:23:40 INFO - 'LANGUAGE': 'en_US:en', 13:23:40 INFO - 'LOGNAME': 'cltbld', 13:23:40 INFO - 'MAIL': '/var/mail/cltbld', 13:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:40 INFO - 'MOZ_NO_REMOTE': '1', 13:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:40 INFO - 'NO_EM_RESTART': '1', 13:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:40 INFO - 'PWD': '/builds/slave/test', 13:23:40 INFO - 'SHELL': '/bin/bash', 13:23:40 INFO - 'SHLVL': '1', 13:23:40 INFO - 'TERM': 'linux', 13:23:40 INFO - 'TMOUT': '86400', 13:23:40 INFO - 'USER': 'cltbld', 13:23:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:40 INFO - '_': '/tools/buildbot/bin/python'} 13:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:41 INFO - Downloading/unpacking jsonschema 13:23:41 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 13:23:41 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 13:23:41 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 13:23:41 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 13:23:41 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 13:23:41 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 13:23:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:43 INFO - Downloading/unpacking functools32 (from jsonschema) 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:43 INFO - warning: no files found matching '*.txt' 13:23:43 INFO - no previously-included directories found matching 'build' 13:23:43 INFO - no previously-included directories found matching 'dist' 13:23:43 INFO - no previously-included directories found matching '.git*' 13:23:43 INFO - Installing collected packages: jsonschema, functools32 13:23:43 INFO - Running setup.py install for functools32 13:23:43 INFO - warning: no files found matching '*.txt' 13:23:43 INFO - no previously-included directories found matching 'build' 13:23:43 INFO - no previously-included directories found matching 'dist' 13:23:43 INFO - no previously-included directories found matching '.git*' 13:23:43 INFO - Successfully installed jsonschema functools32 13:23:43 INFO - Cleaning up... 13:23:43 INFO - Return code: 0 13:23:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:43 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 0x7f10be921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16fb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', '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 13:23:43 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 13:23:43 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 13:23:43 INFO - Using env: {'DISPLAY': ':0', 13:23:43 INFO - 'HOME': '/home/cltbld', 13:23:43 INFO - 'LANG': 'en_US.UTF-8', 13:23:43 INFO - 'LANGUAGE': 'en_US:en', 13:23:43 INFO - 'LOGNAME': 'cltbld', 13:23:43 INFO - 'MAIL': '/var/mail/cltbld', 13:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:43 INFO - 'MOZ_NO_REMOTE': '1', 13:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:43 INFO - 'NO_EM_RESTART': '1', 13:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:43 INFO - 'PWD': '/builds/slave/test', 13:23:43 INFO - 'SHELL': '/bin/bash', 13:23:43 INFO - 'SHLVL': '1', 13:23:43 INFO - 'TERM': 'linux', 13:23:43 INFO - 'TMOUT': '86400', 13:23:43 INFO - 'USER': 'cltbld', 13:23:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:43 INFO - '_': '/tools/buildbot/bin/python'} 13:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:43 INFO - Downloading/unpacking flake8 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:43 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 13:23:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:45 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 13:23:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:46 INFO - no previously-included directories found matching 'docs/_build' 13:23:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:46 INFO - Running setup.py install for pep8 13:23:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:46 INFO - no previously-included directories found matching 'docs/_build' 13:23:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:46 INFO - Cleaning up... 13:23:46 INFO - Return code: 0 13:23:46 INFO - Running post-action listener: _resource_record_post_action 13:23:46 INFO - Running post-action listener: _start_resource_monitoring 13:23:46 INFO - Starting resource monitoring. 13:23:46 INFO - ##### 13:23:46 INFO - ##### Finished create-virtualenv step (success) 13:23:46 INFO - ##### 13:23:46 INFO - ##### 13:23:46 INFO - ##### Running install step. 13:23:46 INFO - ##### 13:23:46 INFO - Running pre-action listener: _resource_record_pre_action 13:23:46 INFO - Running main action method: install 13:23:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:46 INFO - Reading from file tmpfile_stdout 13:23:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:46 INFO - Reading from file tmpfile_stdout 13:23:46 INFO - Output received: 13:23:46 INFO - Usage: mozinstall [options] installer 13:23:46 INFO - Options: 13:23:46 INFO - -h, --help show this help message and exit 13:23:46 INFO - -d DEST, --destination=DEST 13:23:46 INFO - Directory to install application into. [default: 13:23:46 INFO - "/builds/slave/test"] 13:23:46 INFO - --app=APP Application being installed. [default: firefox] 13:23:46 INFO - mkdir: /builds/slave/test/build/application 13:23:46 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'] 13:23:46 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 13:24:03 INFO - Reading from file tmpfile_stdout 13:24:03 INFO - Output received: 13:24:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:24:03 INFO - Running post-action listener: _resource_record_post_action 13:24:03 INFO - ##### 13:24:03 INFO - ##### Finished install step (success) 13:24:03 INFO - ##### 13:24:03 INFO - ##### 13:24:03 INFO - ##### Running run-tests step. 13:24:03 INFO - ##### 13:24:03 INFO - Running pre-action listener: _resource_record_pre_action 13:24:03 INFO - Running main action method: run_tests 13:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:24:03 INFO - Python 2.7.3 13:24:03 INFO - Return code: 0 13:24:03 INFO - grabbing minidump binary from tooltool 13:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:03 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 0x178a9c0>, '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 0x178b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:24:03 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 13:24:03 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 13:24:03 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 13:24:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:24:03 INFO - Return code: 0 13:24:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:24:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:24:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:24:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:24:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:24:04 INFO - Return code: 0 13:24:04 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/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 13:24:04 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/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 13:24:04 INFO - Using env: {'DISPLAY': ':0', 13:24:04 INFO - 'HOME': '/home/cltbld', 13:24:04 INFO - 'LANG': 'en_US.UTF-8', 13:24:04 INFO - 'LANGUAGE': 'en_US:en', 13:24:04 INFO - 'LOGNAME': 'cltbld', 13:24:04 INFO - 'MAIL': '/var/mail/cltbld', 13:24:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:24:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:04 INFO - 'MOZ_NO_REMOTE': '1', 13:24:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:24:04 INFO - 'NO_EM_RESTART': '1', 13:24:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:04 INFO - 'PWD': '/builds/slave/test', 13:24:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:24:04 INFO - 'SHELL': '/bin/bash', 13:24:04 INFO - 'SHLVL': '1', 13:24:04 INFO - 'TERM': 'linux', 13:24:04 INFO - 'TMOUT': '86400', 13:24:04 INFO - 'USER': 'cltbld', 13:24:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809', 13:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:04 INFO - '_': '/tools/buildbot/bin/python'} 13:24:04 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/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 13:24:04 INFO - mozversion application_buildid: 20160519083055 13:24:04 INFO - mozversion application_changeset: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 13:24:04 INFO - mozversion application_display_name: Nightly 13:24:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:24:04 INFO - mozversion application_name: Firefox 13:24:04 INFO - mozversion application_remotingname: firefox 13:24:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:24:04 INFO - mozversion application_vendor: Mozilla 13:24:04 INFO - mozversion application_version: 49.0a1 13:24:04 INFO - mozversion platform_buildid: 20160519083055 13:24:04 INFO - mozversion platform_changeset: ebd649229181d40d9f5ae41ea4d2109c8f782fe8 13:24:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:24:04 INFO - mozversion platform_version: 49.0a1 13:24:04 INFO - using testdate: 1463689444 13:24:04 INFO - actual date: 1463689444 13:24:04 INFO - starting webserver on 'localhost:48314' 13:24:04 INFO - SUITE-START | Running 2 tests 13:24:04 INFO - TEST-START | dromaeo_css 13:24:04 INFO - operating with platform_type : linux_ 13:24:04 INFO - Initialising browser for dromaeo_css test... 13:24:04 INFO - TEST-INFO | started process 7683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUIaZ_/profile http://localhost:48314/getInfo.html) 13:24:09 INFO - PROCESS | 7683 | __metrics Screen width/height:1600/1200 13:24:09 INFO - PROCESS | 7683 | colorDepth:24 13:24:09 INFO - PROCESS | 7683 | Browser inner width/height: 1024/697 13:24:09 INFO - PROCESS | 7683 | __metrics 13:24:10 ERROR - PROCESS | 7683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:24:10 INFO - TEST-INFO | 7683: exit 0 13:24:10 INFO - Browser initialized. 13:24:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:24:10 INFO - TEST-INFO | started process 7764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUIaZ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:22 INFO - PROCESS | 7764 | RSS: Main: 152887296 13:24:22 INFO - PROCESS | 7764 | 13:25:13 INFO - PROCESS | 7764 | 1463689513794 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] 13:27:21 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48314/tests/dromaeo/cssquery-ext.html) 13:27:22 INFO - PROCESS | 7764 | RSS: Main: 241029120 13:27:22 INFO - PROCESS | 7764 | 13:30:25 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-ext.html (next: http://localhost:48314/tests/dromaeo/cssquery-jquery.html) 13:30:25 INFO - PROCESS | 7764 | RSS: Main: 234905600 13:30:25 INFO - PROCESS | 7764 | 13:33:27 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48314/tests/dromaeo/cssquery-mootools.html) 13:33:28 INFO - PROCESS | 7764 | RSS: Main: 236679168 13:33:28 INFO - PROCESS | 7764 | 13:36:30 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48314/tests/dromaeo/cssquery-prototype.html) 13:36:31 INFO - PROCESS | 7764 | RSS: Main: 232665088 13:36:31 INFO - PROCESS | 7764 | 13:39:33 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48314/tests/dromaeo/cssquery-yui.html) 13:39:34 INFO - PROCESS | 7764 | RSS: Main: 220372992 13:39:34 INFO - PROCESS | 7764 | 13:42:36 INFO - PROCESS | 7764 | Cycle 1(1): loaded http://localhost:48314/tests/dromaeo/cssquery-yui.html (next: http://localhost:48314/tests/dromaeo/cssquery-dojo.html) 13:42:37 INFO - PROCESS | 7764 | RSS: Main: 261558272 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | __start_tp_report 13:42:37 INFO - PROCESS | 7764 | _x_x_mozilla_page_load 13:42:37 INFO - PROCESS | 7764 | _x_x_mozilla_page_load_details 13:42:37 INFO - PROCESS | 7764 | |i|pagename|runs| 13:42:37 INFO - PROCESS | 7764 | |0;dojo.html;3165.6359518655363;3166.73082787963;3201.9039428817127;3207.5188721691757;3233.3371658809947;5344.91982620261;5368.865778355543;5443.156310771837;5487.7530511127;5528.668279903209;5430.456954304567;5449.209864569635;5454.154606036071;5459.617826752119;5506.724663766816;4856.951430485703;4892;5041.218611115265;5084;5114.539691427771;4990.675606085593;5042.042012017705;5063.84808455745;5072;5072.036313100499;4829.710217386951;4850.660453768238;4878;4887.951120488785;4987.576056035223;4876.707397556158;4878.048780487807;4898.436679781799;4958.7024778513405;4969.428515720702;4830.372051633265;4874.0251949609865;4883.316335713003;4883.4628190898975;4900.240462728283;5299.364076310829;5327.440618735016;5376.301080859503;5397.217403476513;5444.537214336786;5786.363500014995;5787.826365209051;5794.942050579482;5843.18195452637;5847.883042339129;5929.110633404981;5952.821415357546;5973.193618861442;5982.252218472691;5988.071848863433;5350.0904846176245;5424.864378390533;5453.727313634342;5465.9726701366235;5526.834194974117;6035.394276353312;6066.029435290332;6083.148359229712;6092.482139018233;6095.75616975316;5838.9124163137585;5841.357450680422;5842.036064049469;5845.9707701462075;5849.034909240013;5741.88516229673;5788.3343415506915;5837.124431335249;5839.649621022752;5864.912026319608;5833.679147646835;5837.9124313135335;5846.093855452412;5849.09339052439;5854.063349864001;5664.745086471119;5789.334226563915;5836.358000619928;5838.8540286492325;5842.386549412336;4376.190404775127;4376.868693939187;4394.648428125743;4416.955830441719;4418.337249412614;3901.453796468497;3914.2171565686976;3924.175923056133;3945;3953.189596132786;5467.58993075513;5519.034169020405;5578.30271216098;5578.3584887738425;5584.385717571064;5892.793752218738;5914.970425147847;5945.227120474311;5959.22530071088;5977.312609049928;5615.775368985195;5621.690807005654;5624.91562626561;5626.324841019104;5626.521745651584;4813.253945638432;4922.556969872729;4926.236433352836;4931.457539670633;4976.278439626234;6113.144159817629;6204.441600255908;6208.844778880564;6210.844728881814;6217.471514921192;5981.850453738692;6003.369646187088;6011.175959269837;6014.879702406015;6062.393760624079;5939.940600594112;6100.944524685319;6135.171751813448;6203.4416902479;6215.254169499689;5868.735906884115;5868.823935281948;5870.090136028923;5871.6770577618645;5906.173135761082;5892.1161825726485;5974.492168165754;5975.103734439869;5978.222831031938;6002.399760024137;5604.187392828098;5683.346415162309;5690.544756419394;5740.913886291625;5804.622699524517;5743.224664670216;5745.798897038583;5751.5398768099285;5755.625884317506;5758.62568933018;5620.325560932551;5628.662280263034;5639.2668953035845;5642.153676948491;5645.040343141593;5688.829335119953;5778.27771528559;5813.79651712188;5832.825015249549;5923.170756094237;5731.770729170953;5733.168690539932;5738.426157384395;5741.971290143522;5786.739596718074 13:42:37 INFO - PROCESS | 7764 | |1;ext.html;618.8762247550488;654.8330175805171;658.0556900847284;666.699985006747;669.3239827773947;32126.67873321269;32787.83606081969;34933.650663493354;34958.12604684884;44214.33678494825;42910.57089429105;46563.767181164134;46579.30131048037;46727;46734.76632616841;8876.689315873962;9051.502167380824;9051.683191088314;9053;9056.77358066047;8894.688685895995;9029.95485022574;9038.412503187272;9041.819163616723;9044.8643270351;9014.36899417041;9095.181433670969;9097.63609455621;9101.180893719564;9102.271818254523;9028.052054534277;9062.954685226565;9079.092090790935;9088.227500662419;9088.77301564287;8862.158094980967;8916.955415222947;8920.241779448756;8938.0615035421;8955.059718729504;41320.1735965282;41699.58300416987;41732.79133604343;41762.373564396556;41783;3652.7443078984484;3694.7783133012103;3721.627837216257;3746.4780318793987;3812.5996770338993;32446;32588;32761.836190819133;32840.835795821105;34155.31689366224;4492.887419716676;4493.213687604656;4578.931316030262;4579.587837094644;4715.033418149271;362135;366008;366028;366089;366169.199002064;52528.47471525312;54355;57659.13511297334;59470;59570.40429595735;60968;61090.083648745305;61252.2436490359;61255.693721531105;61327.38672613306;17044.48866534006;17118.48644540666;17211.827881721274;17212;17222.052787096578;11321;13374.598762037154;13439.126456780277;13482.865171348161;13485.932570337085;16572.337106515846;16798.244079016473;17321.220545075248;17322.566935826453;17433.912830435765;5973;6056.909146362808;6083.897212421697;6095.878082438327;6147.754089836446;1015.720676813882;1023.5905637744961;1160.3965937712512;1167.3696204049888;1169.3393232823598;30710.232244193627;31922.185364294106;32204.19489512781;32595.185120371705;32634.67365326364;1142.9028532574823;1161.5179700424399;1240.0761432732672;1240.679988070374;1294.766941950458;16692.165391730607;16965.830341696674;17295.827041729674;17305.56736081583;17399.65200695979;531287;532250;533319;538624;539544;56908.14637780437;57044.714776425855;57060.144097838565;57112;57214.7139264301;1257.182831159735;1367.7743172376645;1382.1983249715342;1403.382511694851;1405.395679857671;32487;33726;33817.49273760847;34012.82993585016;34459.655403446646;50577;59364.406355937615;59410.70294648499;59460;59486.40513594809;453384;454573;456775;457385;460357;24937.750622493542;27440.725592744617;27631.309217268925;27734.722652773213;27760.583591245744;47286.527134729586;47827.76086119547;47875.28187077266;48721.512784871695;48948.75525622349;41429.378559321034;42111.578884210765;42153.57846421497;42226;43138.56861431345;41506.79246603748;41652.79173604112;41837.1632567353;42338.57661423346;42380.788096059325;41444.79277603592;42032.78983605062;42911.356329655704;43406.34890476709;43410.348844767985;36823;37355.81322093372;37390.25219495541;37815.810920945216;38284.808575956944;28888.277793055342;29358.20962461345;29608.40783184281;29630;29765.85117074401 13:42:37 INFO - PROCESS | 7764 | |2;jquery.html;391.61034770403455;392.09817419934154;398.5396866619054;399.9660876633901;414.4136047492798;14015.929920350383;17754.733678994795;18927.24291028359;19658.606827863452;19660.213591456344;15454.104856076467;16900.323987040505;18787.3424430145;19055.428337149908;19214.423567292968;1705.5139285303692;1709.7435384692271;1776.5558610347414;5224.242484839696;5607.887842243153;4070.104576993057;5817.854553636151;5865.296164460271;5879.7648094076185;6114.2357205349335;6360.014197799349;6458.709358078898;6491.285958544557;6502.707378167994;6506.674666266667;6310.148130002437;6407.455366293871;6462.386073323027;6463.385978332051;6476.4818814494965;5649.548036157097;5650.915236271459;5655.547556195535;5658.943410565883;5669.489745922887;20814.37556873296;21802.672959905613;21842.344729658136;22980.885095574584;23250.767492325198;2369.857808531476;2527.734587868284;2600.752928471792;2987.671356150822;3025.2739342557848;10000.149987251092;10143.087122158968;10354.792904141876;10451.059404653543;10536.157107431387;1816.7729033870767;1925.2683980087618;1935.0711658404045;1952.1898412158937;1953.90230488475;80336.19663803405;80880.59559702165;81042;81120.18879811185;81680;10989.890101099047;10999.780004399867;11096;11100.500477478532;11312.830307545393;15289.770653440208;15431.768523472158;15459.768103478456;15470.458533951258;15477.458288960057;8337.416380853403;8346.4157508975;8475.957620211982;8535.359848011423;8570.614322355508;8093.676252949934;8167.469114507538;8225.054118776297;8307.08622051574;8310.542920139329;4210.347396153601;4449.822007119744;4650.837220697259;4703.459102203222;4822.445418776885;1901.096978934995;1929.1222493765304;1935.34198372554;1955.3351860367259;1957.031269521596;934.3786382055993;1009.7627057641448;1035.223582313265;1041.739565108723;1079.896393703922;18826;19268.4219473416;19408.902955485133;19497.22011119568;19652.50868728293;1003.82934901067;1005.7334806276342;1063.5373612478597;1083.6748975307376;1109.4341885638382;10675.946620266848;10919.235653504178;10957.50691218897;11032.28290161137;11041.503132359063;455291;465515;471902;473712;483506;92723.53638231766;94448;95114;95290;95317;1047.5704960965968;1049.3284298049255;1062.3148069495132;1067.396920739795;1068.188176985481;17170.570735731708;17170.91414542969;17191.31234750646;17250.568735781704;17544.736828947833;40543.79728101341;40568.594314056485;41077.38383924184;41177.38233926434;41727.791361043;51686;52541;55351.72324138354;63120.68439657772;63475;8552.743417697478;8711.651533938571;8856.202941735275;8991.14584114508;9135.497547634945;12526.436310365872;13342;13413.195208287534;13903.09629874055;13938.163710177016;12064.879351206375;12316.076294277786;12391.504339826666;12420.937895310466;12634.2419454833;11922.52309907594;11972.281663100242;11986.160968732105;12202.450889709808;12427.31649759272;6878.415334696607;10247.846282305622;11939.52241910314;12187.451564679788;12277.851376009341;7625.6949722010495;8699.826003479768;8788.91211087881;8998.370114091951;9014.594343254701;11498.712532186762;12111.757764844477;12148.635540933787;12304.138710290194;12374.566890159162 13:42:37 INFO - PROCESS | 7764 | |3;mootools.html;1351.1622793867803;1520.9847901520982;1566.4987204094691;1739.4433781190023;1877.2772482594205;8533.27467165291;8887.68893088742;8909.732708018762;9039.90960090399;9083.318751093679;8929.821403571925;9156.862647060283;9157.038510956354;9157.175854173123;9158.633654653822;2080.043180137131;2385.057902128658;2428.5021570577987;2457.938551536217;2465.938351541217;2430.7518371961605;2437.549053425113;2445.5842506773893;2448.4123810285582;2456.828022038458;2410.939726506843;2430.1858877276045;2432.2460037388378;2432.6472661464077;2432.7080750309988;2057.5987682401937;2365.44412063165;2429.8906549205326;2432.622943443769;2461.0278939818672;2327.813774898021;2337.9479234344612;2343.800776933963;2344.7069116360453;2362.5865473542062;9112.498812565307;9169.770755731093;9206.355555111146;9216.631334746602;9227.307951903635;5405.162199858989;5589.469000444992;5597.132444471114;5599.720013999325;5602.691851948141;3556.288742251534;3578.3916734155255;3689.760165589228;3780.4140358244517;3807.714421418377;1137.397179494869;1151.4265616347457;1158.7972104881612;1195.0260537661866;1195.7010747313172;12899.484020639164;12938.611841644766;12955.287459189742;12955.740885182244;12969.935150324281;4791.736454494967;4813.638977076734;4916.901661966741;4929.06347793918;4950.232713929347;10828.025477707044;10886.455677216107;10905.945470272598;10910.836337454944;10918.617848375268;4840.273958906122;5662.603617746719;5666.773329066874;5671.2060311556415;5673.517750991129;4851.126797176472;4972.726500042532;4972.8756781080765;5021.372328458942;5030.119729047402;3998.6478962857054;4042.7776472293717;4046.4941882264716;4063.2076745035024;4063.8577649782114;1305.4908585651604;1318.4396631431796;1325.1651459580596;1329.1559859489294;1333.759923213831;973.8247115519133;980.4313498171186;989.4113002763344;993.3791380387258;1026.9229807764448;5882.264716910387;6068.817935461943;6093.11649810775;6109.450149486567;6288.465480434214;440.1944441671733;448.83841816945875;449.19369731332336;452.31248502276355;452.38701559386556;4024.7383920045104;4034.172994536113;4089.9386509202386;4099.262132816062;4102.958970410317;10882.347059176474;11345.659630210941;11428.828567571492;11432.942835285936;11439.942800285946;11161.386123763108;11364.48859801311;11365.943170284096;11398.373089479992;11404.372759498307;8428.620712067972;8532.36007299455;8548.059713431518;8549.102344253888;8558.61486233121;5844.357120716632;5891.469767720926;5956.970215148896;5981.671008094597;6050.576459647782;10259.333143345659;10491.160707143257;10637.787244255227;10662.360258384211;10681.732956676145;10208.183345332503;10742.785144296913;10752.569897204025;10776.622818201638;10782.838257425989;7259.782206533812;7759.806004849924;7965.243301886311;8169.5506747129475;8247.587620619064;8979.236764875059;8995.685151019683;9082.727518174466;9096.954515227382;9108.316876234176;8012.759617211493;8250.711225107092;8259.669613215405;8350.87473687883;8406.621702023302;7967.442279040411;8109.797255068671;8125.4718443301;8157.877631835646;8266.13205613426;7303.488755787044;7354.485186036926;7457.142428620561;7462.96268518654;7466.850662986819;5224.320838290998;5316.069687804541;5323.228131920927;5390;5417.024935511646;5229.163333866563;5323.920141197807;5518.696471694096;5528.253685752372;5539.612227144061 13:42:37 INFO - PROCESS | 7764 | |4;prototype.html;326.55262290661796;327.09884268839346;334.493242737253;338.06693525868593;339.69766907452356;5249.737513124348;5256.474352564746;5332.813351532697;5385.838424847251;5388.245645609618;5246.6683655878505;5270.5520030797425;5284.2073688946675;5311.1502159654465;5334.546563542094;4010.258102251078;4016.0963783148704;4097;4144.626983571478;4162.188373267214;4143.523494798092;4154.771487568182;4171.478565179353;4173.4157217989505;4177.206330797154;3930.9803450982704;4061.5532291447917;4088.4889388826396;4094.5905409458965;4145.233131870598;4004.2792297386604;4093.7339072960162;4096.467459230281;4097.344424892003;4129.607687269735;3626.9455958160647;3632.4209811034198;3634.4184930411006;3635.72732045095;3655.5613326400735;5078.695278283315;5087.262346959707;5096.311997880276;5126.2054381570915;5147.202183661539;4529.954700452986;4763.761811909425;4798.856034318976;4806.303086052538;4828.420589529279;5497.51567076891;5536.390996990328;5538.529225015878;5553.805616803393;5576.275084239063;4044.737092089005;4052.230076285496;4054.2702313583545;4059.472268605092;4082.387641853716;5633.774649014034;5677.914831277493;5727.570432217559;5808.186853840466;5811.244538210048;4127.9174416511505;4151.443208796702;4171.165766846643;4171.374293855885;4177.373393990865;4217.514985776675;4219.531574029166;4223.746575205498;4229.175310814423;4229.688796473103;4608.147492713859;4790.281457781291;4791.233402655558;4793.448753393334;4798.880027999258;5524.751386187631;5539.2522009529;5582.381109478287;5587.8603034923635;5609.635373700697;1429.814124163852;1451.1293224065475;1458.2344269258724;1460.7662773956115;1462.349254581701;910.7586489580267;914.6478605736706;923.3536524432924;995.9004099590128;1004.6483730694345;5375.247465354853;5386.192071189274;5386.434424385461;5401.189821526724;5408.648437851606;5623.831285061455;5665.206871038058;5678;5710.71446427677;5713.914291285634;5169.741512924339;5364.490373414519;5365.356157261153;5467.507924286833;5507.752151153208;3028.697130286998;3029.33354661974;3046.482098043338;3047.3143542702715;3068.248279171617;5660.433956604389;5916.934951708734;5957.838221546756;5958.165856780054;5976.372480889531;5785.595008349459;5857.26784151981;5888.381719919346;5904.439078287556;5911.586188966731;5905.940940590625;5914.822555323347;5929.221233629807;5997.610155339889;6008.609440386361;5488;5715.542756579547;5716.399778023248;5756.30924289088;5820.952228598893;5654.604177707521;5671.319441667027;5710.8001219957105;5764.913526297025;5772.740226689725;5789.928863160329;5995.070764031582;6001.189839371629;6013.338532761481;6013.857367100237;4071.91856162881;4106.425100485994;4126.958730412657;4153.3769934510065;4166.208420400114;5788.594798364074;5795.840831833566;5797.565182611237;5811.302643682785;5819.6508209507565;5378.220158076979;5516.641418307797;5529.391766905556;5604.346717718365;5605.4114317997655;5584.715515431392;5590.776368945197;5598.412166722435;5610.18652295423;5617.578681598979;5237.266782650356;5438.864028399322;5491.75287112073;5495.395506494362;5500.614956952975;5581.190727344593;5605.225413420383;5608.831735047955;5613.1860880171325;5639.125935480007;5458.181272808952;5470.945290547043;5517.972410137923;5520.558355331484;5550.222968784293 13:42:37 INFO - PROCESS | 7764 | |5;yui.html;820.8522465956128;844.446887288826;855.0765173612499;858.5492616376406;861.9008813986392;14419.206943618097;14935.178565178925;14935.850641493582;14950.925245373757;14958.700825983487;14430.855691443083;14476.203808790513;14502.709945801103;14504.709905801905;14522.709545809077;685.3968507713205;818.1409520003972;828.9419740618159;830.796454868558;841.8947631546057;830.8047608811925;835.9540225287607;838.4005436113177;838.6435764799966;838.9454685445457;724.4385601159091;894.2130924786212;895.2971917045121;896.8430524658191;897.5422534507416;860.513809697522;872.3675335381829;872.5375550957971;883.2007033634571;885.3404213860715;650.9511786615975;651.2413038809781;651.3388910256047;651.690447037658;651.8207492939432;13653.180809151383;13756.17462952226;13769;13786.103903246258;13794.517191898336;13416.262105584188;13730.45078196871;13753.312334383341;13836.377363018688;13843.792343114761;11789.233699809485;11870.287782733063;12107.93946030273;12128.393580321037;12309.26144431328;4359;4434.889127771799;4471.932921006188;4587.655925805578;4638.489766125724;58628.99999999957;59022.704886475294;59041.40958590402;59117.704411478095;59133.40866591322;11199.328040317607;11283;11306.660800176009;11363.03414209785;11509.366984815915;20032.399028029184;20142.798572014384;20191.091400886995;20207.090680919395;20243.089060991995;8285.088640249567;8429.789255268544;8480.703175388831;8575.571221438902;8672.176143266379;4746.59653929413;4771.642126840501;4784.091022705675;4795.568398844121;4815.783289751969;3307.8676852926096;3387.830608469567;3393.6606339365867;3396.083057574441;3405.1316914186723;513.1840373805667;574.4026212738788;603.4508597176635;628.2774808969722;635.0284065379976;699.9825004374932;768.2816566510219;774.2799196747079;780.7345502529167;804.3484777330381;10078.092971632588;10214.693559193236;10243.436610986468;10282.794344113076;10286.074253317087;750.5271678842295;757.6817736550662;771.5949126708523;782.4640121516779;787.271773609409;4749.311349854252;4770.117528257283;4789.712617242976;4820.855374338776;4862.465128835825;76863.23136768672;76935;77807;79618.60190699126;79810.60094699489;64569;65783.34216657867;65891;66961.33038669649;67798;60063.69968150131;60095.69952150299;60335;60577.39422605718;61734.69132654308;9108.134727200906;9336.95331523338;9484.525773711424;9529.142377186086;9563.426194428357;36952.63047369492;37375.14123163971;40496;41188.38217426681;42128.3680744783;50378.748106260704;50752.746236268584;51317.23024154716;51620;52021.7398913003;11339.489722962322;11389.715257118638;11653.359065251492;12734.490620375453;12995.220286782824;12440.75118497643;12771;12787.168834025759;13104.344782761014;13195.60413187606;9429.62281508732;11734.061275098142;11837;12122.393880305774;12377.62867113988;13105.672358191121;13222.66943326386;13248.20510769357;13359.53241636538;13545.458181672622;12678.936605316914;13317.933410332886;13430.798538022133;13709;13715.657108572366;9915.900840991786;10579.523921423708;10603.257771955889;10733.570657173626;10873.510692018719;10844.566217351217;10869.130469562575;10888.237823352289;11060.115190784878;11148.88851111511 13:42:37 INFO - PROCESS | 7764 | __end_tp_report 13:42:37 INFO - PROCESS | 7764 | __start_cc_report 13:42:37 INFO - PROCESS | 7764 | _x_x_mozilla_cycle_collect,1003 13:42:37 INFO - PROCESS | 7764 | __end_cc_report 13:42:37 INFO - PROCESS | 7764 | __startTimestamp1463690557063__endTimestamp 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | ------- Summary: start ------- 13:42:37 INFO - PROCESS | 7764 | Number of tests: 6 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#0] dojo.html Cycles:165 Average:5452.41 Median:5683.35 stddev:652.55 (11.5%) stddev-sans-first:629.41 13:42:37 INFO - PROCESS | 7764 | Values: 3165.6 3166.7 3201.9 3207.5 3233.3 5344.9 5368.9 5443.2 5487.8 5528.7 5430.5 5449.2 5454.2 5459.6 5506.7 4857.0 4892.0 5041.2 5084.0 5114.5 4990.7 5042.0 5063.8 5072.0 5072.0 4829.7 4850.7 4878.0 4888.0 4987.6 4876.7 4878.0 4898.4 4958.7 4969.4 4830.4 4874.0 4883.3 4883.5 4900.2 5299.4 5327.4 5376.3 5397.2 5444.5 5786.4 5787.8 5794.9 5843.2 5847.9 5929.1 5952.8 5973.2 5982.3 5988.1 5350.1 5424.9 5453.7 5466.0 5526.8 6035.4 6066.0 6083.1 6092.5 6095.8 5838.9 5841.4 5842.0 5846.0 5849.0 5741.9 5788.3 5837.1 5839.6 5864.9 5833.7 5837.9 5846.1 5849.1 5854.1 5664.7 5789.3 5836.4 5838.9 5842.4 4376.2 4376.9 4394.6 4417.0 4418.3 3901.5 3914.2 3924.2 3945.0 3953.2 5467.6 5519.0 5578.3 5578.4 5584.4 5892.8 5915.0 5945.2 5959.2 5977.3 5615.8 5621.7 5624.9 5626.3 5626.5 4813.3 4922.6 4926.2 4931.5 4976.3 6113.1 6204.4 6208.8 6210.8 6217.5 5981.9 6003.4 6011.2 6014.9 6062.4 5939.9 6100.9 6135.2 6203.4 6215.3 5868.7 5868.8 5870.1 5871.7 5906.2 5892.1 5974.5 5975.1 5978.2 6002.4 5604.2 5683.3 5690.5 5740.9 5804.6 5743.2 5745.8 5751.5 5755.6 5758.6 5620.3 5628.7 5639.3 5642.2 5645.0 5688.8 5778.3 5813.8 5832.8 5923.2 5731.8 5733.2 5738.4 5742.0 5786.7 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#1] ext.html Cycles:180 Average:61351.99 Median:42132.58 stddev:121299.28 (287.9%) stddev-sans-first:121553.85 13:42:37 INFO - PROCESS | 7764 | Values: 618.9 654.8 658.1 666.7 669.3 32126.7 32787.8 34933.7 34958.1 44214.3 42910.6 46563.8 46579.3 46727.0 46734.8 8876.7 9051.5 9051.7 9053.0 9056.8 8894.7 9030.0 9038.4 9041.8 9044.9 9014.4 9095.2 9097.6 9101.2 9102.3 9028.1 9063.0 9079.1 9088.2 9088.8 8862.2 8917.0 8920.2 8938.1 8955.1 41320.2 41699.6 41732.8 41762.4 41783.0 3652.7 3694.8 3721.6 3746.5 3812.6 32446.0 32588.0 32761.8 32840.8 34155.3 4492.9 4493.2 4578.9 4579.6 4715.0 362135.0 366008.0 366028.0 366089.0 366169.2 52528.5 54355.0 57659.1 59470.0 59570.4 60968.0 61090.1 61252.2 61255.7 61327.4 17044.5 17118.5 17211.8 17212.0 17222.1 11321.0 13374.6 13439.1 13482.9 13485.9 16572.3 16798.2 17321.2 17322.6 17433.9 5973.0 6056.9 6083.9 6095.9 6147.8 1015.7 1023.6 1160.4 1167.4 1169.3 30710.2 31922.2 32204.2 32595.2 32634.7 1142.9 1161.5 1240.1 1240.7 1294.8 16692.2 16965.8 17295.8 17305.6 17399.7 531287.0 532250.0 533319.0 538624.0 539544.0 56908.1 57044.7 57060.1 57112.0 57214.7 1257.2 1367.8 1382.2 1403.4 1405.4 32487.0 33726.0 33817.5 34012.8 34459.7 50577.0 59364.4 59410.7 59460.0 59486.4 453384.0 454573.0 456775.0 457385.0 460357.0 24937.8 27440.7 27631.3 27734.7 27760.6 47286.5 47827.8 47875.3 48721.5 48948.8 41429.4 42111.6 42153.6 42226.0 43138.6 41506.8 41652.8 41837.2 42338.6 42380.8 41444.8 42032.8 42911.4 43406.3 43410.3 36823.0 37355.8 37390.3 37815.8 38284.8 28888.3 29358.2 29608.4 29630.0 29765.9 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#2] jquery.html Cycles:180 Average:28416.25 Median:20237.29 stddev:77681.79 (383.9%) stddev-sans-first:77871.21 13:42:37 INFO - PROCESS | 7764 | Values: 391.6 392.1 398.5 400.0 414.4 14015.9 17754.7 18927.2 19658.6 19660.2 15454.1 16900.3 18787.3 19055.4 19214.4 1705.5 1709.7 1776.6 5224.2 5607.9 4070.1 5817.9 5865.3 5879.8 6114.2 6360.0 6458.7 6491.3 6502.7 6506.7 6310.1 6407.5 6462.4 6463.4 6476.5 5649.5 5650.9 5655.5 5658.9 5669.5 20814.4 21802.7 21842.3 22980.9 23250.8 2369.9 2527.7 2600.8 2987.7 3025.3 10000.1 10143.1 10354.8 10451.1 10536.2 1816.8 1925.3 1935.1 1952.2 1953.9 80336.2 80880.6 81042.0 81120.2 81680.0 10989.9 10999.8 11096.0 11100.5 11312.8 15289.8 15431.8 15459.8 15470.5 15477.5 8337.4 8346.4 8476.0 8535.4 8570.6 8093.7 8167.5 8225.1 8307.1 8310.5 4210.3 4449.8 4650.8 4703.5 4822.4 1901.1 1929.1 1935.3 1955.3 1957.0 934.4 1009.8 1035.2 1041.7 1079.9 18826.0 19268.4 19408.9 19497.2 19652.5 1003.8 1005.7 1063.5 1083.7 1109.4 10675.9 10919.2 10957.5 11032.3 11041.5 455291.0 465515.0 471902.0 473712.0 483506.0 92723.5 94448.0 95114.0 95290.0 95317.0 1047.6 1049.3 1062.3 1067.4 1068.2 17170.6 17170.9 17191.3 17250.6 17544.7 40543.8 40568.6 41077.4 41177.4 41727.8 51686.0 52541.0 55351.7 63120.7 63475.0 8552.7 8711.7 8856.2 8991.1 9135.5 12526.4 13342.0 13413.2 13903.1 13938.2 12064.9 12316.1 12391.5 12420.9 12634.2 11922.5 11972.3 11986.2 12202.5 12427.3 6878.4 10247.8 11939.5 12187.5 12277.9 7625.7 8699.8 8788.9 8998.4 9014.6 11498.7 12111.8 12148.6 12304.1 12374.6 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#3] mootools.html Cycles:180 Average:6030.19 Median:2622.06 stddev:3477.19 (132.6%) stddev-sans-first:3469.16 13:42:37 INFO - PROCESS | 7764 | Values: 1351.2 1521.0 1566.5 1739.4 1877.3 8533.3 8887.7 8909.7 9039.9 9083.3 8929.8 9156.9 9157.0 9157.2 9158.6 2080.0 2385.1 2428.5 2457.9 2465.9 2430.8 2437.5 2445.6 2448.4 2456.8 2410.9 2430.2 2432.2 2432.6 2432.7 2057.6 2365.4 2429.9 2432.6 2461.0 2327.8 2337.9 2343.8 2344.7 2362.6 9112.5 9169.8 9206.4 9216.6 9227.3 5405.2 5589.5 5597.1 5599.7 5602.7 3556.3 3578.4 3689.8 3780.4 3807.7 1137.4 1151.4 1158.8 1195.0 1195.7 12899.5 12938.6 12955.3 12955.7 12969.9 4791.7 4813.6 4916.9 4929.1 4950.2 10828.0 10886.5 10905.9 10910.8 10918.6 4840.3 5662.6 5666.8 5671.2 5673.5 4851.1 4972.7 4972.9 5021.4 5030.1 3998.6 4042.8 4046.5 4063.2 4063.9 1305.5 1318.4 1325.2 1329.2 1333.8 973.8 980.4 989.4 993.4 1026.9 5882.3 6068.8 6093.1 6109.5 6288.5 440.2 448.8 449.2 452.3 452.4 4024.7 4034.2 4089.9 4099.3 4103.0 10882.3 11345.7 11428.8 11432.9 11439.9 11161.4 11364.5 11365.9 11398.4 11404.4 8428.6 8532.4 8548.1 8549.1 8558.6 5844.4 5891.5 5957.0 5981.7 6050.6 10259.3 10491.2 10637.8 10662.4 10681.7 10208.2 10742.8 10752.6 10776.6 10782.8 7259.8 7759.8 7965.2 8169.6 8247.6 8979.2 8995.7 9082.7 9097.0 9108.3 8012.8 8250.7 8259.7 8350.9 8406.6 7967.4 8109.8 8125.5 8157.9 8266.1 7303.5 7354.5 7457.1 7463.0 7466.9 5224.3 5316.1 5323.2 5390.0 5417.0 5229.2 5323.9 5518.7 5528.3 5539.6 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#4] prototype.html Cycles:180 Average:4707.13 Median:5386.02 stddev:1382.25 (25.7%) stddev-sans-first:1346.46 13:42:37 INFO - PROCESS | 7764 | Values: 326.6 327.1 334.5 338.1 339.7 5249.7 5256.5 5332.8 5385.8 5388.2 5246.7 5270.6 5284.2 5311.2 5334.5 4010.3 4016.1 4097.0 4144.6 4162.2 4143.5 4154.8 4171.5 4173.4 4177.2 3931.0 4061.6 4088.5 4094.6 4145.2 4004.3 4093.7 4096.5 4097.3 4129.6 3626.9 3632.4 3634.4 3635.7 3655.6 5078.7 5087.3 5096.3 5126.2 5147.2 4530.0 4763.8 4798.9 4806.3 4828.4 5497.5 5536.4 5538.5 5553.8 5576.3 4044.7 4052.2 4054.3 4059.5 4082.4 5633.8 5677.9 5727.6 5808.2 5811.2 4127.9 4151.4 4171.2 4171.4 4177.4 4217.5 4219.5 4223.7 4229.2 4229.7 4608.1 4790.3 4791.2 4793.4 4798.9 5524.8 5539.3 5582.4 5587.9 5609.6 1429.8 1451.1 1458.2 1460.8 1462.3 910.8 914.6 923.4 995.9 1004.6 5375.2 5386.2 5386.4 5401.2 5408.6 5623.8 5665.2 5678.0 5710.7 5713.9 5169.7 5364.5 5365.4 5467.5 5507.8 3028.7 3029.3 3046.5 3047.3 3068.2 5660.4 5916.9 5957.8 5958.2 5976.4 5785.6 5857.3 5888.4 5904.4 5911.6 5905.9 5914.8 5929.2 5997.6 6008.6 5488.0 5715.5 5716.4 5756.3 5821.0 5654.6 5671.3 5710.8 5764.9 5772.7 5789.9 5995.1 6001.2 6013.3 6013.9 4071.9 4106.4 4127.0 4153.4 4166.2 5788.6 5795.8 5797.6 5811.3 5819.7 5378.2 5516.6 5529.4 5604.3 5605.4 5584.7 5590.8 5598.4 5610.2 5617.6 5237.3 5438.9 5491.8 5495.4 5500.6 5581.2 5605.2 5608.8 5613.2 5639.1 5458.2 5470.9 5518.0 5520.6 5550.2 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - PROCESS | 7764 | [#5] yui.html Cycles:180 Average:16451.66 Median:4770.88 stddev:20449.34 (428.6%) stddev-sans-first:20473.02 13:42:37 INFO - PROCESS | 7764 | Values: 820.9 844.4 855.1 858.5 861.9 14419.2 14935.2 14935.9 14950.9 14958.7 14430.9 14476.2 14502.7 14504.7 14522.7 685.4 818.1 828.9 830.8 841.9 830.8 836.0 838.4 838.6 838.9 724.4 894.2 895.3 896.8 897.5 860.5 872.4 872.5 883.2 885.3 651.0 651.2 651.3 651.7 651.8 13653.2 13756.2 13769.0 13786.1 13794.5 13416.3 13730.5 13753.3 13836.4 13843.8 11789.2 11870.3 12107.9 12128.4 12309.3 4359.0 4434.9 4471.9 4587.7 4638.5 58629.0 59022.7 59041.4 59117.7 59133.4 11199.3 11283.0 11306.7 11363.0 11509.4 20032.4 20142.8 20191.1 20207.1 20243.1 8285.1 8429.8 8480.7 8575.6 8672.2 4746.6 4771.6 4784.1 4795.6 4815.8 3307.9 3387.8 3393.7 3396.1 3405.1 513.2 574.4 603.5 628.3 635.0 700.0 768.3 774.3 780.7 804.3 10078.1 10214.7 10243.4 10282.8 10286.1 750.5 757.7 771.6 782.5 787.3 4749.3 4770.1 4789.7 4820.9 4862.5 76863.2 76935.0 77807.0 79618.6 79810.6 64569.0 65783.3 65891.0 66961.3 67798.0 60063.7 60095.7 60335.0 60577.4 61734.7 9108.1 9337.0 9484.5 9529.1 9563.4 36952.6 37375.1 40496.0 41188.4 42128.4 50378.7 50752.7 51317.2 51620.0 52021.7 11339.5 11389.7 11653.4 12734.5 12995.2 12440.8 12771.0 12787.2 13104.3 13195.6 9429.6 11734.1 11837.0 12122.4 12377.6 13105.7 13222.7 13248.2 13359.5 13545.5 12678.9 13317.9 13430.8 13709.0 13715.7 9915.9 10579.5 10603.3 10733.6 10873.5 10844.6 10869.1 10888.2 11060.1 11148.9 13:42:37 INFO - PROCESS | 7764 | -------- Summary: end -------- 13:42:37 INFO - PROCESS | 7764 | 13:42:37 INFO - TEST-INFO | 7764: exit 0 13:42:37 INFO - TEST-OK | dromaeo_css | took 1113170ms 13:42:37 INFO - TEST-START | kraken 13:42:37 INFO - operating with platform_type : linux_ 13:42:37 INFO - Initialising browser for kraken test... 13:42:37 INFO - TEST-INFO | started process 7943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkpK0ym/profile http://localhost:48314/getInfo.html) 13:42:42 INFO - PROCESS | 7943 | __metrics Screen width/height:1600/1200 13:42:42 INFO - PROCESS | 7943 | colorDepth:24 13:42:42 INFO - PROCESS | 7943 | Browser inner width/height: 1024/697 13:42:42 INFO - PROCESS | 7943 | __metrics 13:42:43 ERROR - PROCESS | 7943 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:42:43 INFO - TEST-INFO | 7943: exit 0 13:42:43 INFO - Browser initialized. 13:42:43 INFO - Running cycle 1/1 for kraken test... 13:42:43 INFO - TEST-INFO | started process 8024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkpK0ym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:55 INFO - PROCESS | 8024 | RSS: Main: 152907776 13:42:55 INFO - PROCESS | 8024 | 13:42:58 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48314/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:59 INFO - PROCESS | 8024 | RSS: Main: 209272832 13:42:59 INFO - PROCESS | 8024 | 13:43:01 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48314/tests/kraken/driver.html?testName=audio-dft) 13:43:02 INFO - PROCESS | 8024 | RSS: Main: 198496256 13:43:02 INFO - PROCESS | 8024 | 13:43:05 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48314/tests/kraken/driver.html?testName=audio-fft) 13:43:06 INFO - PROCESS | 8024 | RSS: Main: 265580544 13:43:06 INFO - PROCESS | 8024 | 13:43:08 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48314/tests/kraken/driver.html?testName=audio-oscillator) 13:43:09 INFO - PROCESS | 8024 | RSS: Main: 175300608 13:43:09 INFO - PROCESS | 8024 | 13:43:11 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:43:11 INFO - PROCESS | 8024 | RSS: Main: 179044352 13:43:11 INFO - PROCESS | 8024 | 13:43:15 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48314/tests/kraken/driver.html?testName=imaging-darkroom) 13:43:15 INFO - PROCESS | 8024 | RSS: Main: 214540288 13:43:15 INFO - PROCESS | 8024 | 13:43:19 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48314/tests/kraken/driver.html?testName=imaging-desaturate) 13:43:19 INFO - PROCESS | 8024 | RSS: Main: 213319680 13:43:19 INFO - PROCESS | 8024 | 13:43:22 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48314/tests/kraken/driver.html?testName=json-parse-financial) 13:43:23 INFO - PROCESS | 8024 | RSS: Main: 213442560 13:43:23 INFO - PROCESS | 8024 | 13:43:25 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:25 INFO - PROCESS | 8024 | RSS: Main: 201428992 13:43:25 INFO - PROCESS | 8024 | 13:43:27 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:28 INFO - PROCESS | 8024 | RSS: Main: 207929344 13:43:28 INFO - PROCESS | 8024 | 13:43:30 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:30 INFO - PROCESS | 8024 | RSS: Main: 218583040 13:43:30 INFO - PROCESS | 8024 | 13:43:33 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:34 INFO - PROCESS | 8024 | RSS: Main: 224251904 13:43:34 INFO - PROCESS | 8024 | 13:43:36 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:37 INFO - PROCESS | 8024 | RSS: Main: 222019584 13:43:37 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | Cycle 1(1): loaded http://localhost:48314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48314/tests/kraken/driver.html?testName=ai-astar) 13:43:39 INFO - PROCESS | 8024 | RSS: Main: 267419648 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | __start_tp_report 13:43:39 INFO - PROCESS | 8024 | _x_x_mozilla_page_load 13:43:39 INFO - PROCESS | 8024 | _x_x_mozilla_page_load_details 13:43:39 INFO - PROCESS | 8024 | |i|pagename|runs| 13:43:39 INFO - PROCESS | 8024 | |0;ai-astar;109;104;109;108;108;109;109;109;111;108 13:43:39 INFO - PROCESS | 8024 | |1;audio-beat-detection;159;125;147;201;127;153;155;127;180;136 13:43:39 INFO - PROCESS | 8024 | |2;audio-dft;162;161;160;159;159;160;160;160;160;161 13:43:39 INFO - PROCESS | 8024 | |3;audio-fft;73;74;74;150;76;73;74;75;125;75 13:43:39 INFO - PROCESS | 8024 | |4;audio-oscillator;92;91;147;92;90;91;126;91;92;124 13:43:39 INFO - PROCESS | 8024 | |5;imaging-gaussian-blur;116;117;116;117;116;117;125;117;118;117 13:43:39 INFO - PROCESS | 8024 | |6;imaging-darkroom;144;145;145;145;145;145;145;145;145;144 13:43:39 INFO - PROCESS | 8024 | |7;imaging-desaturate;94;95;95;95;94;94;95;95;95;94 13:43:39 INFO - PROCESS | 8024 | |8;json-parse-financial;56;54;56;54;55;54;53;106;53;54 13:43:39 INFO - PROCESS | 8024 | |9;json-stringify-tinderbox;58;59;58;58;58;57;58;59;58;57 13:43:39 INFO - PROCESS | 8024 | |10;stanford-crypto-aes;78;79;79;83;84;84;83;78;81;79 13:43:39 INFO - PROCESS | 8024 | |11;stanford-crypto-ccm;123;124;128;119;122;133;119;117;203;121 13:43:39 INFO - PROCESS | 8024 | |12;stanford-crypto-pbkdf2;164;161;166;164;161;161;161;160;159;158 13:43:39 INFO - PROCESS | 8024 | |13;stanford-crypto-sha256-iterative;62;62;66;63;62;69;63;60;64;60 13:43:39 INFO - PROCESS | 8024 | __end_tp_report 13:43:39 INFO - PROCESS | 8024 | __start_cc_report 13:43:39 INFO - PROCESS | 8024 | _x_x_mozilla_cycle_collect,1834 13:43:39 INFO - PROCESS | 8024 | __end_cc_report 13:43:39 INFO - PROCESS | 8024 | __startTimestamp1463690619534__endTimestamp 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | ------- Summary: start ------- 13:43:39 INFO - PROCESS | 8024 | Number of tests: 14 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:1.78 (1.6%) stddev-sans-first:1.87 13:43:39 INFO - PROCESS | 8024 | Values: 109.0 104.0 109.0 108.0 108.0 109.0 109.0 109.0 111.0 108.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:154.00 stddev:24.71 (16.0%) stddev-sans-first:26.04 13:43:39 INFO - PROCESS | 8024 | Values: 159.0 125.0 147.0 201.0 127.0 153.0 155.0 127.0 180.0 136.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 13:43:39 INFO - PROCESS | 8024 | Values: 162.0 161.0 160.0 159.0 159.0 160.0 160.0 160.0 160.0 161.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#3] audio-fft Cycles:10 Average:86.90 Median:74.00 stddev:27.33 (36.9%) stddev-sans-first:28.52 13:43:39 INFO - PROCESS | 8024 | Values: 73.0 74.0 74.0 150.0 76.0 73.0 74.0 75.0 125.0 75.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:91.00 stddev:20.73 (22.8%) stddev-sans-first:21.55 13:43:39 INFO - PROCESS | 8024 | Values: 92.0 91.0 147.0 92.0 90.0 91.0 126.0 91.0 92.0 124.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:2.67 (2.3%) stddev-sans-first:2.77 13:43:39 INFO - PROCESS | 8024 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 125.0 117.0 118.0 117.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 13:43:39 INFO - PROCESS | 8024 | Values: 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:43:39 INFO - PROCESS | 8024 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:54.00 stddev:16.37 (30.3%) stddev-sans-first:17.32 13:43:39 INFO - PROCESS | 8024 | Values: 56.0 54.0 56.0 54.0 55.0 54.0 53.0 106.0 53.0 54.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 13:43:39 INFO - PROCESS | 8024 | Values: 58.0 59.0 58.0 58.0 58.0 57.0 58.0 59.0 58.0 57.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:82.00 stddev:2.49 (3.0%) stddev-sans-first:2.42 13:43:39 INFO - PROCESS | 8024 | Values: 78.0 79.0 79.0 83.0 84.0 84.0 83.0 78.0 81.0 79.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:123.50 stddev:25.77 (20.9%) stddev-sans-first:27.17 13:43:39 INFO - PROCESS | 8024 | Values: 123.0 124.0 128.0 119.0 122.0 133.0 119.0 117.0 203.0 121.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.00 stddev:2.46 (1.5%) stddev-sans-first:2.44 13:43:39 INFO - PROCESS | 8024 | Values: 164.0 161.0 166.0 164.0 161.0 161.0 161.0 160.0 159.0 158.0 13:43:39 INFO - PROCESS | 8024 | 13:43:39 INFO - PROCESS | 8024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.73 (4.3%) stddev-sans-first:2.86 13:43:39 INFO - PROCESS | 8024 | Values: 62.0 62.0 66.0 63.0 62.0 69.0 63.0 60.0 64.0 60.0 13:43:39 INFO - PROCESS | 8024 | -------- Summary: end -------- 13:43:39 INFO - PROCESS | 8024 | 13:43:40 INFO - TEST-INFO | 8024: exit 0 13:43:40 INFO - TEST-OK | kraken | took 62724ms 13:43:40 INFO - SUITE-END | took 1175s 13:43:40 INFO - Completed test suite (00:19:36) 13:43:40 INFO - javascript benchmark 13:43:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.6359518655363, 3166.73082787963, 3201.9039428817127, 3207.5188721691757, 3233.3371658809947, 5344.91982620261, 5368.865778355543, 5443.156310771837, 5487.7530511127, 5528.668279903209, 5430.456954304567, 5449.209864569635, 5454.154606036071, 5459.617826752119, 5506.724663766816, 4856.951430485703, 4892.0, 5041.218611115265, 5084.0, 5114.539691427771, 4990.675606085593, 5042.042012017705, 5063.84808455745, 5072.0, 5072.036313100499, 4829.710217386951, 4850.660453768238, 4878.0, 4887.951120488785, 4987.576056035223, 4876.707397556158, 4878.048780487807, 4898.436679781799, 4958.7024778513405, 4969.428515720702, 4830.372051633265, 4874.0251949609865, 4883.316335713003, 4883.4628190898975, 4900.240462728283, 5299.364076310829, 5327.440618735016, 5376.301080859503, 5397.217403476513, 5444.537214336786, 5786.363500014995, 5787.826365209051, 5794.942050579482, 5843.18195452637, 5847.883042339129, 5929.110633404981, 5952.821415357546, 5973.193618861442, 5982.252218472691, 5988.071848863433, 5350.0904846176245, 5424.864378390533, 5453.727313634342, 5465.9726701366235, 5526.834194974117, 6035.394276353312, 6066.029435290332, 6083.148359229712, 6092.482139018233, 6095.75616975316, 5838.9124163137585, 5841.357450680422, 5842.036064049469, 5845.9707701462075, 5849.034909240013, 5741.88516229673, 5788.3343415506915, 5837.124431335249, 5839.649621022752, 5864.912026319608, 5833.679147646835, 5837.9124313135335, 5846.093855452412, 5849.09339052439, 5854.063349864001, 5664.745086471119, 5789.334226563915, 5836.358000619928, 5838.8540286492325, 5842.386549412336, 4376.190404775127, 4376.868693939187, 4394.648428125743, 4416.955830441719, 4418.337249412614, 3901.453796468497, 3914.2171565686976, 3924.175923056133, 3945.0, 3953.189596132786, 5467.58993075513, 5519.034169020405, 5578.30271216098, 5578.3584887738425, 5584.385717571064, 5892.793752218738, 5914.970425147847, 5945.227120474311, 5959.22530071088, 5977.312609049928, 5615.775368985195, 5621.690807005654, 5624.91562626561, 5626.324841019104, 5626.521745651584, 4813.253945638432, 4922.556969872729, 4926.236433352836, 4931.457539670633, 4976.278439626234, 6113.144159817629, 6204.441600255908, 6208.844778880564, 6210.844728881814, 6217.471514921192, 5981.850453738692, 6003.369646187088, 6011.175959269837, 6014.879702406015, 6062.393760624079, 5939.940600594112, 6100.944524685319, 6135.171751813448, 6203.4416902479, 6215.254169499689, 5868.735906884115, 5868.823935281948, 5870.090136028923, 5871.6770577618645, 5906.173135761082, 5892.1161825726485, 5974.492168165754, 5975.103734439869, 5978.222831031938, 6002.399760024137, 5604.187392828098, 5683.346415162309, 5690.544756419394, 5740.913886291625, 5804.622699524517, 5743.224664670216, 5745.798897038583, 5751.5398768099285, 5755.625884317506, 5758.62568933018, 5620.325560932551, 5628.662280263034, 5639.2668953035845, 5642.153676948491, 5645.040343141593, 5688.829335119953, 5778.27771528559, 5813.79651712188, 5832.825015249549, 5923.170756094237, 5731.770729170953, 5733.168690539932, 5738.426157384395, 5741.971290143522, 5786.739596718074], "value": 5406.562089728853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.8762247550488, 654.8330175805171, 658.0556900847284, 666.699985006747, 669.3239827773947, 32126.67873321269, 32787.83606081969, 34933.650663493354, 34958.12604684884, 44214.33678494825, 42910.57089429105, 46563.767181164134, 46579.30131048037, 46727.0, 46734.76632616841, 8876.689315873962, 9051.502167380824, 9051.683191088314, 9053.0, 9056.77358066047, 8894.688685895995, 9029.95485022574, 9038.412503187272, 9041.819163616723, 9044.8643270351, 9014.36899417041, 9095.181433670969, 9097.63609455621, 9101.180893719564, 9102.271818254523, 9028.052054534277, 9062.954685226565, 9079.092090790935, 9088.227500662419, 9088.77301564287, 8862.158094980967, 8916.955415222947, 8920.241779448756, 8938.0615035421, 8955.059718729504, 41320.1735965282, 41699.58300416987, 41732.79133604343, 41762.373564396556, 41783.0, 3652.7443078984484, 3694.7783133012103, 3721.627837216257, 3746.4780318793987, 3812.5996770338993, 32446.0, 32588.0, 32761.836190819133, 32840.835795821105, 34155.31689366224, 4492.887419716676, 4493.213687604656, 4578.931316030262, 4579.587837094644, 4715.033418149271, 362135.0, 366008.0, 366028.0, 366089.0, 366169.199002064, 52528.47471525312, 54355.0, 57659.13511297334, 59470.0, 59570.40429595735, 60968.0, 61090.083648745305, 61252.2436490359, 61255.693721531105, 61327.38672613306, 17044.48866534006, 17118.48644540666, 17211.827881721274, 17212.0, 17222.052787096578, 11321.0, 13374.598762037154, 13439.126456780277, 13482.865171348161, 13485.932570337085, 16572.337106515846, 16798.244079016473, 17321.220545075248, 17322.566935826453, 17433.912830435765, 5973.0, 6056.909146362808, 6083.897212421697, 6095.878082438327, 6147.754089836446, 1015.720676813882, 1023.5905637744961, 1160.3965937712512, 1167.3696204049888, 1169.3393232823598, 30710.232244193627, 31922.185364294106, 32204.19489512781, 32595.185120371705, 32634.67365326364, 1142.9028532574823, 1161.5179700424399, 1240.0761432732672, 1240.679988070374, 1294.766941950458, 16692.165391730607, 16965.830341696674, 17295.827041729674, 17305.56736081583, 17399.65200695979, 531287.0, 532250.0, 533319.0, 538624.0, 539544.0, 56908.14637780437, 57044.714776425855, 57060.144097838565, 57112.0, 57214.7139264301, 1257.182831159735, 1367.7743172376645, 1382.1983249715342, 1403.382511694851, 1405.395679857671, 32487.0, 33726.0, 33817.49273760847, 34012.82993585016, 34459.655403446646, 50577.0, 59364.406355937615, 59410.70294648499, 59460.0, 59486.40513594809, 453384.0, 454573.0, 456775.0, 457385.0, 460357.0, 24937.750622493542, 27440.725592744617, 27631.309217268925, 27734.722652773213, 27760.583591245744, 47286.527134729586, 47827.76086119547, 47875.28187077266, 48721.512784871695, 48948.75525622349, 41429.378559321034, 42111.578884210765, 42153.57846421497, 42226.0, 43138.56861431345, 41506.79246603748, 41652.79173604112, 41837.1632567353, 42338.57661423346, 42380.788096059325, 41444.79277603592, 42032.78983605062, 42911.356329655704, 43406.34890476709, 43410.348844767985, 36823.0, 37355.81322093372, 37390.25219495541, 37815.810920945216, 38284.808575956944, 28888.277793055342, 29358.20962461345, 29608.40783184281, 29630.0, 29765.85117074401], "value": 20363.007520975258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.61034770403455, 392.09817419934154, 398.5396866619054, 399.9660876633901, 414.4136047492798, 14015.929920350383, 17754.733678994795, 18927.24291028359, 19658.606827863452, 19660.213591456344, 15454.104856076467, 16900.323987040505, 18787.3424430145, 19055.428337149908, 19214.423567292968, 1705.5139285303692, 1709.7435384692271, 1776.5558610347414, 5224.242484839696, 5607.887842243153, 4070.104576993057, 5817.854553636151, 5865.296164460271, 5879.7648094076185, 6114.2357205349335, 6360.014197799349, 6458.709358078898, 6491.285958544557, 6502.707378167994, 6506.674666266667, 6310.148130002437, 6407.455366293871, 6462.386073323027, 6463.385978332051, 6476.4818814494965, 5649.548036157097, 5650.915236271459, 5655.547556195535, 5658.943410565883, 5669.489745922887, 20814.37556873296, 21802.672959905613, 21842.344729658136, 22980.885095574584, 23250.767492325198, 2369.857808531476, 2527.734587868284, 2600.752928471792, 2987.671356150822, 3025.2739342557848, 10000.149987251092, 10143.087122158968, 10354.792904141876, 10451.059404653543, 10536.157107431387, 1816.7729033870767, 1925.2683980087618, 1935.0711658404045, 1952.1898412158937, 1953.90230488475, 80336.19663803405, 80880.59559702165, 81042.0, 81120.18879811185, 81680.0, 10989.890101099047, 10999.780004399867, 11096.0, 11100.500477478532, 11312.830307545393, 15289.770653440208, 15431.768523472158, 15459.768103478456, 15470.458533951258, 15477.458288960057, 8337.416380853403, 8346.4157508975, 8475.957620211982, 8535.359848011423, 8570.614322355508, 8093.676252949934, 8167.469114507538, 8225.054118776297, 8307.08622051574, 8310.542920139329, 4210.347396153601, 4449.822007119744, 4650.837220697259, 4703.459102203222, 4822.445418776885, 1901.096978934995, 1929.1222493765304, 1935.34198372554, 1955.3351860367259, 1957.031269521596, 934.3786382055993, 1009.7627057641448, 1035.223582313265, 1041.739565108723, 1079.896393703922, 18826.0, 19268.4219473416, 19408.902955485133, 19497.22011119568, 19652.50868728293, 1003.82934901067, 1005.7334806276342, 1063.5373612478597, 1083.6748975307376, 1109.4341885638382, 10675.946620266848, 10919.235653504178, 10957.50691218897, 11032.28290161137, 11041.503132359063, 455291.0, 465515.0, 471902.0, 473712.0, 483506.0, 92723.53638231766, 94448.0, 95114.0, 95290.0, 95317.0, 1047.5704960965968, 1049.3284298049255, 1062.3148069495132, 1067.396920739795, 1068.188176985481, 17170.570735731708, 17170.91414542969, 17191.31234750646, 17250.568735781704, 17544.736828947833, 40543.79728101341, 40568.594314056485, 41077.38383924184, 41177.38233926434, 41727.791361043, 51686.0, 52541.0, 55351.72324138354, 63120.68439657772, 63475.0, 8552.743417697478, 8711.651533938571, 8856.202941735275, 8991.14584114508, 9135.497547634945, 12526.436310365872, 13342.0, 13413.195208287534, 13903.09629874055, 13938.163710177016, 12064.879351206375, 12316.076294277786, 12391.504339826666, 12420.937895310466, 12634.2419454833, 11922.52309907594, 11972.281663100242, 11986.160968732105, 12202.450889709808, 12427.31649759272, 6878.415334696607, 10247.846282305622, 11939.52241910314, 12187.451564679788, 12277.851376009341, 7625.6949722010495, 8699.826003479768, 8788.91211087881, 8998.370114091951, 9014.594343254701, 11498.712532186762, 12111.757764844477, 12148.635540933787, 12304.138710290194, 12374.566890159162], "value": 9184.055004040056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.1622793867803, 1520.9847901520982, 1566.4987204094691, 1739.4433781190023, 1877.2772482594205, 8533.27467165291, 8887.68893088742, 8909.732708018762, 9039.90960090399, 9083.318751093679, 8929.821403571925, 9156.862647060283, 9157.038510956354, 9157.175854173123, 9158.633654653822, 2080.043180137131, 2385.057902128658, 2428.5021570577987, 2457.938551536217, 2465.938351541217, 2430.7518371961605, 2437.549053425113, 2445.5842506773893, 2448.4123810285582, 2456.828022038458, 2410.939726506843, 2430.1858877276045, 2432.2460037388378, 2432.6472661464077, 2432.7080750309988, 2057.5987682401937, 2365.44412063165, 2429.8906549205326, 2432.622943443769, 2461.0278939818672, 2327.813774898021, 2337.9479234344612, 2343.800776933963, 2344.7069116360453, 2362.5865473542062, 9112.498812565307, 9169.770755731093, 9206.355555111146, 9216.631334746602, 9227.307951903635, 5405.162199858989, 5589.469000444992, 5597.132444471114, 5599.720013999325, 5602.691851948141, 3556.288742251534, 3578.3916734155255, 3689.760165589228, 3780.4140358244517, 3807.714421418377, 1137.397179494869, 1151.4265616347457, 1158.7972104881612, 1195.0260537661866, 1195.7010747313172, 12899.484020639164, 12938.611841644766, 12955.287459189742, 12955.740885182244, 12969.935150324281, 4791.736454494967, 4813.638977076734, 4916.901661966741, 4929.06347793918, 4950.232713929347, 10828.025477707044, 10886.455677216107, 10905.945470272598, 10910.836337454944, 10918.617848375268, 4840.273958906122, 5662.603617746719, 5666.773329066874, 5671.2060311556415, 5673.517750991129, 4851.126797176472, 4972.726500042532, 4972.8756781080765, 5021.372328458942, 5030.119729047402, 3998.6478962857054, 4042.7776472293717, 4046.4941882264716, 4063.2076745035024, 4063.8577649782114, 1305.4908585651604, 1318.4396631431796, 1325.1651459580596, 1329.1559859489294, 1333.759923213831, 973.8247115519133, 980.4313498171186, 989.4113002763344, 993.3791380387258, 1026.9229807764448, 5882.264716910387, 6068.817935461943, 6093.11649810775, 6109.450149486567, 6288.465480434214, 440.1944441671733, 448.83841816945875, 449.19369731332336, 452.31248502276355, 452.38701559386556, 4024.7383920045104, 4034.172994536113, 4089.9386509202386, 4099.262132816062, 4102.958970410317, 10882.347059176474, 11345.659630210941, 11428.828567571492, 11432.942835285936, 11439.942800285946, 11161.386123763108, 11364.48859801311, 11365.943170284096, 11398.373089479992, 11404.372759498307, 8428.620712067972, 8532.36007299455, 8548.059713431518, 8549.102344253888, 8558.61486233121, 5844.357120716632, 5891.469767720926, 5956.970215148896, 5981.671008094597, 6050.576459647782, 10259.333143345659, 10491.160707143257, 10637.787244255227, 10662.360258384211, 10681.732956676145, 10208.183345332503, 10742.785144296913, 10752.569897204025, 10776.622818201638, 10782.838257425989, 7259.782206533812, 7759.806004849924, 7965.243301886311, 8169.5506747129475, 8247.587620619064, 8979.236764875059, 8995.685151019683, 9082.727518174466, 9096.954515227382, 9108.316876234176, 8012.759617211493, 8250.711225107092, 8259.669613215405, 8350.87473687883, 8406.621702023302, 7967.442279040411, 8109.797255068671, 8125.4718443301, 8157.877631835646, 8266.13205613426, 7303.488755787044, 7354.485186036926, 7457.142428620561, 7462.96268518654, 7466.850662986819, 5224.320838290998, 5316.069687804541, 5323.228131920927, 5390.0, 5417.024935511646, 5229.163333866563, 5323.920141197807, 5518.696471694096, 5528.253685752372, 5539.612227144061], "value": 4721.372437263061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.55262290661796, 327.09884268839346, 334.493242737253, 338.06693525868593, 339.69766907452356, 5249.737513124348, 5256.474352564746, 5332.813351532697, 5385.838424847251, 5388.245645609618, 5246.6683655878505, 5270.5520030797425, 5284.2073688946675, 5311.1502159654465, 5334.546563542094, 4010.258102251078, 4016.0963783148704, 4097.0, 4144.626983571478, 4162.188373267214, 4143.523494798092, 4154.771487568182, 4171.478565179353, 4173.4157217989505, 4177.206330797154, 3930.9803450982704, 4061.5532291447917, 4088.4889388826396, 4094.5905409458965, 4145.233131870598, 4004.2792297386604, 4093.7339072960162, 4096.467459230281, 4097.344424892003, 4129.607687269735, 3626.9455958160647, 3632.4209811034198, 3634.4184930411006, 3635.72732045095, 3655.5613326400735, 5078.695278283315, 5087.262346959707, 5096.311997880276, 5126.2054381570915, 5147.202183661539, 4529.954700452986, 4763.761811909425, 4798.856034318976, 4806.303086052538, 4828.420589529279, 5497.51567076891, 5536.390996990328, 5538.529225015878, 5553.805616803393, 5576.275084239063, 4044.737092089005, 4052.230076285496, 4054.2702313583545, 4059.472268605092, 4082.387641853716, 5633.774649014034, 5677.914831277493, 5727.570432217559, 5808.186853840466, 5811.244538210048, 4127.9174416511505, 4151.443208796702, 4171.165766846643, 4171.374293855885, 4177.373393990865, 4217.514985776675, 4219.531574029166, 4223.746575205498, 4229.175310814423, 4229.688796473103, 4608.147492713859, 4790.281457781291, 4791.233402655558, 4793.448753393334, 4798.880027999258, 5524.751386187631, 5539.2522009529, 5582.381109478287, 5587.8603034923635, 5609.635373700697, 1429.814124163852, 1451.1293224065475, 1458.2344269258724, 1460.7662773956115, 1462.349254581701, 910.7586489580267, 914.6478605736706, 923.3536524432924, 995.9004099590128, 1004.6483730694345, 5375.247465354853, 5386.192071189274, 5386.434424385461, 5401.189821526724, 5408.648437851606, 5623.831285061455, 5665.206871038058, 5678.0, 5710.71446427677, 5713.914291285634, 5169.741512924339, 5364.490373414519, 5365.356157261153, 5467.507924286833, 5507.752151153208, 3028.697130286998, 3029.33354661974, 3046.482098043338, 3047.3143542702715, 3068.248279171617, 5660.433956604389, 5916.934951708734, 5957.838221546756, 5958.165856780054, 5976.372480889531, 5785.595008349459, 5857.26784151981, 5888.381719919346, 5904.439078287556, 5911.586188966731, 5905.940940590625, 5914.822555323347, 5929.221233629807, 5997.610155339889, 6008.609440386361, 5488.0, 5715.542756579547, 5716.399778023248, 5756.30924289088, 5820.952228598893, 5654.604177707521, 5671.319441667027, 5710.8001219957105, 5764.913526297025, 5772.740226689725, 5789.928863160329, 5995.070764031582, 6001.189839371629, 6013.338532761481, 6013.857367100237, 4071.91856162881, 4106.425100485994, 4126.958730412657, 4153.3769934510065, 4166.208420400114, 5788.594798364074, 5795.840831833566, 5797.565182611237, 5811.302643682785, 5819.6508209507565, 5378.220158076979, 5516.641418307797, 5529.391766905556, 5604.346717718365, 5605.4114317997655, 5584.715515431392, 5590.776368945197, 5598.412166722435, 5610.18652295423, 5617.578681598979, 5237.266782650356, 5438.864028399322, 5491.75287112073, 5495.395506494362, 5500.614956952975, 5581.190727344593, 5605.225413420383, 5608.831735047955, 5613.1860880171325, 5639.125935480007, 5458.181272808952, 5470.945290547043, 5517.972410137923, 5520.558355331484, 5550.222968784293], "value": 4266.728770858662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.8522465956128, 844.446887288826, 855.0765173612499, 858.5492616376406, 861.9008813986392, 14419.206943618097, 14935.178565178925, 14935.850641493582, 14950.925245373757, 14958.700825983487, 14430.855691443083, 14476.203808790513, 14502.709945801103, 14504.709905801905, 14522.709545809077, 685.3968507713205, 818.1409520003972, 828.9419740618159, 830.796454868558, 841.8947631546057, 830.8047608811925, 835.9540225287607, 838.4005436113177, 838.6435764799966, 838.9454685445457, 724.4385601159091, 894.2130924786212, 895.2971917045121, 896.8430524658191, 897.5422534507416, 860.513809697522, 872.3675335381829, 872.5375550957971, 883.2007033634571, 885.3404213860715, 650.9511786615975, 651.2413038809781, 651.3388910256047, 651.690447037658, 651.8207492939432, 13653.180809151383, 13756.17462952226, 13769.0, 13786.103903246258, 13794.517191898336, 13416.262105584188, 13730.45078196871, 13753.312334383341, 13836.377363018688, 13843.792343114761, 11789.233699809485, 11870.287782733063, 12107.93946030273, 12128.393580321037, 12309.26144431328, 4359.0, 4434.889127771799, 4471.932921006188, 4587.655925805578, 4638.489766125724, 58628.99999999957, 59022.704886475294, 59041.40958590402, 59117.704411478095, 59133.40866591322, 11199.328040317607, 11283.0, 11306.660800176009, 11363.03414209785, 11509.366984815915, 20032.399028029184, 20142.798572014384, 20191.091400886995, 20207.090680919395, 20243.089060991995, 8285.088640249567, 8429.789255268544, 8480.703175388831, 8575.571221438902, 8672.176143266379, 4746.59653929413, 4771.642126840501, 4784.091022705675, 4795.568398844121, 4815.783289751969, 3307.8676852926096, 3387.830608469567, 3393.6606339365867, 3396.083057574441, 3405.1316914186723, 513.1840373805667, 574.4026212738788, 603.4508597176635, 628.2774808969722, 635.0284065379976, 699.9825004374932, 768.2816566510219, 774.2799196747079, 780.7345502529167, 804.3484777330381, 10078.092971632588, 10214.693559193236, 10243.436610986468, 10282.794344113076, 10286.074253317087, 750.5271678842295, 757.6817736550662, 771.5949126708523, 782.4640121516779, 787.271773609409, 4749.311349854252, 4770.117528257283, 4789.712617242976, 4820.855374338776, 4862.465128835825, 76863.23136768672, 76935.0, 77807.0, 79618.60190699126, 79810.60094699489, 64569.0, 65783.34216657867, 65891.0, 66961.33038669649, 67798.0, 60063.69968150131, 60095.69952150299, 60335.0, 60577.39422605718, 61734.69132654308, 9108.134727200906, 9336.95331523338, 9484.525773711424, 9529.142377186086, 9563.426194428357, 36952.63047369492, 37375.14123163971, 40496.0, 41188.38217426681, 42128.3680744783, 50378.748106260704, 50752.746236268584, 51317.23024154716, 51620.0, 52021.7398913003, 11339.489722962322, 11389.715257118638, 11653.359065251492, 12734.490620375453, 12995.220286782824, 12440.75118497643, 12771.0, 12787.168834025759, 13104.344782761014, 13195.60413187606, 9429.62281508732, 11734.061275098142, 11837.0, 12122.393880305774, 12377.62867113988, 13105.672358191121, 13222.66943326386, 13248.20510769357, 13359.53241636538, 13545.458181672622, 12678.936605316914, 13317.933410332886, 13430.798538022133, 13709.0, 13715.657108572366, 9915.900840991786, 10579.523921423708, 10603.257771955889, 10733.570657173626, 10873.510692018719, 10844.566217351217, 10869.130469562575, 10888.237823352289, 11060.115190784878, 11148.88851111511], "value": 7093.236219633332, "unit": "score"}], "name": "dromaeo_css", "value": 7243.941271498646, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 109.0, 108.0, 108.0, 109.0, 109.0, 109.0, 111.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 147.0, 201.0, 127.0, 153.0, 155.0, 127.0, 180.0, 136.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 159.0, 159.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 150.0, 76.0, 73.0, 74.0, 75.0, 125.0, 75.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 147.0, 92.0, 90.0, 91.0, 126.0, 91.0, 92.0, 124.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 125.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0], "value": 144.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 55.0, 54.0, 53.0, 106.0, 53.0, 54.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 57.0, 58.0, 59.0, 58.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 83.0, 84.0, 84.0, 83.0, 78.0, 81.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 128.0, 119.0, 122.0, 133.0, 119.0, 117.0, 203.0, 121.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 166.0, 164.0, 161.0, 161.0, 161.0, 160.0, 159.0, 158.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 66.0, 63.0, 62.0, 69.0, 63.0, 60.0, 64.0, 60.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1520.8999999999999, "alertThreshold": 2.0}]} 13:43:40 INFO - Return code: 0 13:43:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:43:40 ERROR - # TBPL SUCCESS # 13:43:40 INFO - Running post-action listener: _resource_record_post_action 13:43:40 INFO - ##### 13:43:40 INFO - ##### Finished run-tests step (success) 13:43:40 INFO - ##### 13:43:40 INFO - Running post-run listener: _resource_record_post_run 13:43:40 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 151552; Write bytes: 288505856; Read time: 56; Write time: 194592 13:43:40 INFO - TinderboxPrint: CPU usage
13.1% 13:43:40 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 56 13:43:40 INFO - TinderboxPrint: I/O write bytes / time
288,505,856 / 194,592 13:43:40 INFO - TinderboxPrint: CPU idle
8,285.4 (86.9%) 13:43:40 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 13:43:40 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1273856; Read time: 0; Write time: 44 13:43:40 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 151552; Write bytes: 287232000; Read time: 56; Write time: 194548 13:43:41 INFO - Running post-run listener: _upload_blobber_files 13:43:41 INFO - Blob upload gear active. 13:43:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:41 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 13:43:41 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'] 13:43:41 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 13:43:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:47 INFO - (blobuploader) - INFO - Done attempting. 13:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:51 INFO - (blobuploader) - INFO - Done attempting. 13:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:52 INFO - (blobuploader) - INFO - Done attempting. 13:43:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:52 INFO - Return code: 0 13:43:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a559d6661d9ccc3df1eb87104a87ee0dffcfba4314c6debbcb7aa9ac116fbae924cc93120a3c11e36c0ecaa2be3a8943aa1b289f273a91a6869c308bfcbd924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91dd36c35b3a0741a521fa51037eadeae4341c9feec7dbdf66d891e4708f7c960f3391dfe7341b96b6a7c3ea516f8ce7d0641e073d7262652b87c156f0e8c1e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e46e37d3badd07385dc8e2f54352a14ed00c12b0af1bc3453f9d7f20459bc5549ff845b42b7d1faea469f913c69c80bdac69bdafc5eaffe40d629a6285ff91c6"} 13:43:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:52 INFO - Contents: 13:43:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a559d6661d9ccc3df1eb87104a87ee0dffcfba4314c6debbcb7aa9ac116fbae924cc93120a3c11e36c0ecaa2be3a8943aa1b289f273a91a6869c308bfcbd924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91dd36c35b3a0741a521fa51037eadeae4341c9feec7dbdf66d891e4708f7c960f3391dfe7341b96b6a7c3ea516f8ce7d0641e073d7262652b87c156f0e8c1e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e46e37d3badd07385dc8e2f54352a14ed00c12b0af1bc3453f9d7f20459bc5549ff845b42b7d1faea469f913c69c80bdac69bdafc5eaffe40d629a6285ff91c6"} 13:43:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:52 INFO - Copying logs to upload dir... 13:43:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.795368 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-19 13:43:52.020594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 13:43:52.023976) ========= 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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 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/1a559d6661d9ccc3df1eb87104a87ee0dffcfba4314c6debbcb7aa9ac116fbae924cc93120a3c11e36c0ecaa2be3a8943aa1b289f273a91a6869c308bfcbd924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91dd36c35b3a0741a521fa51037eadeae4341c9feec7dbdf66d891e4708f7c960f3391dfe7341b96b6a7c3ea516f8ce7d0641e073d7262652b87c156f0e8c1e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e46e37d3badd07385dc8e2f54352a14ed00c12b0af1bc3453f9d7f20459bc5549ff845b42b7d1faea469f913c69c80bdac69bdafc5eaffe40d629a6285ff91c6"} build_url:https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/aaMPtJ3GStSgcGDEN2bGpg/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/1a559d6661d9ccc3df1eb87104a87ee0dffcfba4314c6debbcb7aa9ac116fbae924cc93120a3c11e36c0ecaa2be3a8943aa1b289f273a91a6869c308bfcbd924", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91dd36c35b3a0741a521fa51037eadeae4341c9feec7dbdf66d891e4708f7c960f3391dfe7341b96b6a7c3ea516f8ce7d0641e073d7262652b87c156f0e8c1e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e46e37d3badd07385dc8e2f54352a14ed00c12b0af1bc3453f9d7f20459bc5549ff845b42b7d1faea469f913c69c80bdac69bdafc5eaffe40d629a6285ff91c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 13:43:52.048706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:43:52.049049) ========= 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=920470bf432669ad7e3a5387000001ca-1463689379.891176-766692809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 13:43:52.135543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 13:43:52.136079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 13:43:52.136544) ========= ========= Total master_lag: 0.18 =========