builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1464663678.08 results: success (0) buildid: 20160530173007 builduid: 823a5a77dae04dda9129639a90408260 revision: 3a87296fe4145138c2ce15512bb31f76fe869cb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.085294) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.085777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.086101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.111329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.111665) ========= 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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 20:01:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-05-30 20:01:18 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088571 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.217261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.217770) ========= 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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.268824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 20:01:18.269226) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3a87296fe4145138c2ce15512bb31f76fe869cb4 --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 3a87296fe4145138c2ce15512bb31f76fe869cb4 --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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 20:01:18,495 truncating revision to first 12 chars 2016-05-30 20:01:18,496 Setting DEBUG logging. 2016-05-30 20:01:18,496 attempt 1/10 2016-05-30 20:01:18,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3a87296fe414?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 20:01:19,616 unpacking tar archive at: fx-team-3a87296fe414/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 20:01:19.739514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:19.739827) ========= script_repo_revision: 3a87296fe4145138c2ce15512bb31f76fe869cb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:19.740233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:19.740523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:19.750759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-30 20:01:19.751127) ========= /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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:20 INFO - MultiFileLogger online at 20160530 20:01:20 in /builds/slave/test 20:01:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:01:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:20 INFO - {'append_to_log': False, 20:01:20 INFO - 'base_work_dir': '/builds/slave/test', 20:01:20 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:20 INFO - 'branch': 'Fx-Team', 20:01:20 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:20 INFO - 'config_files': ('talos/linux_config.py',), 20:01:20 INFO - 'default_actions': ('clobber', 20:01:20 INFO - 'read-buildbot-config', 20:01:20 INFO - 'download-and-extract', 20:01:20 INFO - 'populate-webroot', 20:01:20 INFO - 'create-virtualenv', 20:01:20 INFO - 'install', 20:01:20 INFO - 'run-tests'), 20:01:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:20 INFO - 'download_minidump_stackwalk': True, 20:01:20 INFO - 'download_symbols': 'ondemand', 20:01:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:20 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:20 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:20 INFO - 'installer_path': 'installer.exe', 20:01:20 INFO - 'log_level': 'info', 20:01:20 INFO - 'log_name': 'talos', 20:01:20 INFO - 'log_to_console': True, 20:01:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:20 INFO - 'opt_config_files': (), 20:01:20 INFO - 'pip_index': False, 20:01:20 INFO - 'sps_profile': False, 20:01:20 INFO - 'sps_profile_interval': 0, 20:01:20 INFO - 'suite': 'dromaeojs', 20:01:20 INFO - 'system_bits': '32', 20:01:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:20 INFO - 'title': 'talos-linux64-ix-038', 20:01:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:20 INFO - 'use_talos_json': True, 20:01:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:20 INFO - 'work_dir': 'build'} 20:01:20 INFO - ##### 20:01:20 INFO - ##### Running clobber step. 20:01:20 INFO - ##### 20:01:20 INFO - Running pre-action listener: _resource_record_pre_action 20:01:20 INFO - Running main action method: clobber 20:01:20 INFO - rmtree: /builds/slave/test/build 20:01:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:21 INFO - Running post-action listener: _resource_record_post_action 20:01:21 INFO - ##### 20:01:21 INFO - ##### Finished clobber step (success) 20:01:21 INFO - ##### 20:01:21 INFO - ##### 20:01:21 INFO - ##### Running read-buildbot-config step. 20:01:21 INFO - ##### 20:01:21 INFO - Running pre-action listener: _resource_record_pre_action 20:01:21 INFO - Running main action method: read_buildbot_config 20:01:21 INFO - Using buildbot properties: 20:01:21 INFO - { 20:01:21 INFO - "project": "", 20:01:21 INFO - "product": "firefox", 20:01:21 INFO - "script_repo_revision": "production", 20:01:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:01:21 INFO - "repository": "", 20:01:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:01:21 INFO - "buildid": "20160530173007", 20:01:21 INFO - "pgo_build": "True", 20:01:21 INFO - "basedir": "/builds/slave/test", 20:01:21 INFO - "buildnumber": 141, 20:01:21 INFO - "slavename": "talos-linux64-ix-038", 20:01:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:01:21 INFO - "platform": "ubuntu64_hw", 20:01:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:21 INFO - "branch": "fx-team", 20:01:21 INFO - "repo_path": "integration/fx-team", 20:01:21 INFO - "revision": "3a87296fe4145138c2ce15512bb31f76fe869cb4", 20:01:21 INFO - "stage_platform": "linux64-pgo", 20:01:21 INFO - "builduid": "823a5a77dae04dda9129639a90408260", 20:01:21 INFO - "slavebuilddir": "test" 20:01:21 INFO - } 20:01:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:01:21 INFO - Running post-action listener: _resource_record_post_action 20:01:21 INFO - ##### 20:01:21 INFO - ##### Finished read-buildbot-config step (success) 20:01:21 INFO - ##### 20:01:21 INFO - ##### 20:01:21 INFO - ##### Running download-and-extract step. 20:01:21 INFO - ##### 20:01:21 INFO - Running pre-action listener: _resource_record_pre_action 20:01:21 INFO - Running main action method: download_and_extract 20:01:21 INFO - mkdir: /builds/slave/test/build/tests 20:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:21 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:01:29 INFO - Downloaded 1361 bytes. 20:01:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:29 INFO - Using the following test package requirements: 20:01:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'jsshell-linux-x86_64.zip'], 20:01:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:01: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')]} 20:01:29 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:32 INFO - Downloaded 24410718 bytes. 20:01:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:33 INFO - Return code: 0 20:01:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:33 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:43 INFO - Downloaded 24410718 bytes. 20:01:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:44 INFO - Return code: 0 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:44 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:01:45 INFO - Downloaded 10834055 bytes. 20:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:01:45 INFO - Return code: 0 20:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:45 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:01:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:01:47 INFO - Downloaded 58945452 bytes. 20:01:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:47 INFO - mkdir: /builds/slave/test/properties 20:01:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:47 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:47 INFO - Contents: 20:01:47 INFO - build_url:https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:47 INFO - Running post-action listener: _resource_record_post_action 20:01:47 INFO - Running post-action listener: set_extra_try_arguments 20:01:47 INFO - ##### 20:01:47 INFO - ##### Finished download-and-extract step (success) 20:01:47 INFO - ##### 20:01:47 INFO - ##### 20:01:47 INFO - ##### Running populate-webroot step. 20:01:47 INFO - ##### 20:01:47 INFO - Running pre-action listener: _resource_record_pre_action 20:01:47 INFO - Running main action method: populate_webroot 20:01:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:47 INFO - '--tppagecycles', 20:01:47 INFO - '7'], 20:01:47 INFO - 'tests': ['tsvgm']}}, 20:01:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['damp', 'tps']}, 20:01:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'tests': ['damp', 'tps']}, 20:01:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['dromaeo_dom']}, 20:01:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['a11yr', 20:01:47 INFO - 'ts_paint', 20:01:47 INFO - 'tpaint', 20:01:47 INFO - 'sessionrestore', 20:01:47 INFO - 'sessionrestore_no_auto_restore', 20:01:47 INFO - 'tabpaint']}, 20:01:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['tsvgx', 20:01:47 INFO - 'tsvgr_opacity', 20:01:47 INFO - 'tart', 20:01:47 INFO - 'tscrollx', 20:01:47 INFO - 'cart']}, 20:01:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:47 INFO - 'tsvgr_opacity', 20:01:47 INFO - 'tart', 20:01:47 INFO - 'tscrollx', 20:01:47 INFO - 'cart']}, 20:01:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'talos_options': ['--disable-e10s'], 20:01:47 INFO - 'tests': ['tp5o']}, 20:01:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'tests': ['tp5o']}, 20:01:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'talos_options': ['--disable-e10s', 20:01:47 INFO - '--xperf_path', 20:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:47 INFO - 'tests': ['tp5n']}, 20:01:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:47 INFO - 'talos_options': ['--xperf_path', 20:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:47 INFO - 'tests': ['tp5n']}}, 20:01:47 INFO - 'talos.zip': {'path': '', 20:01:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:47 INFO - Running post-action listener: _resource_record_post_action 20:01:47 INFO - ##### 20:01:47 INFO - ##### Finished populate-webroot step (success) 20:01:47 INFO - ##### 20:01:47 INFO - ##### 20:01:47 INFO - ##### Running create-virtualenv step. 20:01:47 INFO - ##### 20:01:47 INFO - Running pre-action listener: _resource_record_pre_action 20:01:47 INFO - Running main action method: create_virtualenv 20:01:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:01:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:48 INFO - Using real prefix '/usr' 20:01:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:50 INFO - Installing pip.................done. 20:01:50 INFO - Return code: 0 20:01:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:01:50 INFO - Using env: {'DISPLAY': ':0', 20:01:50 INFO - 'HOME': '/home/cltbld', 20:01:50 INFO - 'LANG': 'en_US.UTF-8', 20:01:50 INFO - 'LANGUAGE': 'en_US:en', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MAIL': '/var/mail/cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SHLVL': '1', 20:01:50 INFO - 'TERM': 'linux', 20:01:50 INFO - 'TMOUT': '86400', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - '_': '/tools/buildbot/bin/python'} 20:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:01:50 INFO - Cleaning up... 20:01:50 INFO - Return code: 0 20:01:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:50 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:01:50 INFO - Using env: {'DISPLAY': ':0', 20:01:50 INFO - 'HOME': '/home/cltbld', 20:01:50 INFO - 'LANG': 'en_US.UTF-8', 20:01:50 INFO - 'LANGUAGE': 'en_US:en', 20:01:50 INFO - 'LOGNAME': 'cltbld', 20:01:50 INFO - 'MAIL': '/var/mail/cltbld', 20:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:50 INFO - 'MOZ_NO_REMOTE': '1', 20:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:50 INFO - 'NO_EM_RESTART': '1', 20:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:50 INFO - 'PWD': '/builds/slave/test', 20:01:50 INFO - 'SHELL': '/bin/bash', 20:01:50 INFO - 'SHLVL': '1', 20:01:50 INFO - 'TERM': 'linux', 20:01:50 INFO - 'TMOUT': '86400', 20:01:50 INFO - 'USER': 'cltbld', 20:01:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:50 INFO - '_': '/tools/buildbot/bin/python'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 INFO - Downloading/unpacking psutil>=3.1.1 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:53 INFO - Installing collected packages: psutil 20:01:53 INFO - Running setup.py install for psutil 20:01:53 INFO - building 'psutil._psutil_linux' extension 20:01:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:01:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:01:53 INFO - building 'psutil._psutil_posix' extension 20:01:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:01:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:53 INFO - Successfully installed psutil 20:01:53 INFO - Cleaning up... 20:01:53 INFO - Return code: 0 20:01:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:53 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:01:53 INFO - Using env: {'DISPLAY': ':0', 20:01:53 INFO - 'HOME': '/home/cltbld', 20:01:53 INFO - 'LANG': 'en_US.UTF-8', 20:01:53 INFO - 'LANGUAGE': 'en_US:en', 20:01:53 INFO - 'LOGNAME': 'cltbld', 20:01:53 INFO - 'MAIL': '/var/mail/cltbld', 20:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:53 INFO - 'MOZ_NO_REMOTE': '1', 20:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:53 INFO - 'NO_EM_RESTART': '1', 20:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:53 INFO - 'PWD': '/builds/slave/test', 20:01:53 INFO - 'SHELL': '/bin/bash', 20:01:53 INFO - 'SHLVL': '1', 20:01:53 INFO - 'TERM': 'linux', 20:01:53 INFO - 'TMOUT': '86400', 20:01:53 INFO - 'USER': 'cltbld', 20:01:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:53 INFO - '_': '/tools/buildbot/bin/python'} 20:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:01:55 INFO - Installing collected packages: mozsystemmonitor 20:01:55 INFO - Running setup.py install for mozsystemmonitor 20:01:55 INFO - Successfully installed mozsystemmonitor 20:01:55 INFO - Cleaning up... 20:01:55 INFO - Return code: 0 20:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:01:55 INFO - Using env: {'DISPLAY': ':0', 20:01:55 INFO - 'HOME': '/home/cltbld', 20:01:55 INFO - 'LANG': 'en_US.UTF-8', 20:01:55 INFO - 'LANGUAGE': 'en_US:en', 20:01:55 INFO - 'LOGNAME': 'cltbld', 20:01:55 INFO - 'MAIL': '/var/mail/cltbld', 20:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:55 INFO - 'MOZ_NO_REMOTE': '1', 20:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:55 INFO - 'NO_EM_RESTART': '1', 20:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:55 INFO - 'PWD': '/builds/slave/test', 20:01:55 INFO - 'SHELL': '/bin/bash', 20:01:55 INFO - 'SHLVL': '1', 20:01:55 INFO - 'TERM': 'linux', 20:01:55 INFO - 'TMOUT': '86400', 20:01:55 INFO - 'USER': 'cltbld', 20:01:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:55 INFO - '_': '/tools/buildbot/bin/python'} 20:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:56 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:59 INFO - Downloading docopt-0.6.1.tar.gz 20:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:59 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:59 INFO - Running setup.py install for blobuploader 20:01:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:01:59 INFO - Running setup.py install for requests 20:01:59 INFO - Running setup.py install for docopt 20:01:59 INFO - Successfully installed blobuploader requests docopt 20:01:59 INFO - Cleaning up... 20:01:59 INFO - Return code: 0 20:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:59 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:01:59 INFO - Using env: {'DISPLAY': ':0', 20:01:59 INFO - 'HOME': '/home/cltbld', 20:01:59 INFO - 'LANG': 'en_US.UTF-8', 20:01:59 INFO - 'LANGUAGE': 'en_US:en', 20:01:59 INFO - 'LOGNAME': 'cltbld', 20:01:59 INFO - 'MAIL': '/var/mail/cltbld', 20:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:59 INFO - 'MOZ_NO_REMOTE': '1', 20:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:59 INFO - 'NO_EM_RESTART': '1', 20:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:59 INFO - 'PWD': '/builds/slave/test', 20:01:59 INFO - 'SHELL': '/bin/bash', 20:01:59 INFO - 'SHLVL': '1', 20:01:59 INFO - 'TERM': 'linux', 20:01:59 INFO - 'TMOUT': '86400', 20:01:59 INFO - 'USER': 'cltbld', 20:01:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:59 INFO - '_': '/tools/buildbot/bin/python'} 20:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:00 INFO - Running setup.py (path:/tmp/pip-geLu2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:00 INFO - Running setup.py (path:/tmp/pip-E8hdDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:00 INFO - Running setup.py (path:/tmp/pip-xkLfrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:00 INFO - Running setup.py (path:/tmp/pip-3EPPQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:00 INFO - Running setup.py (path:/tmp/pip-yUAdGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:00 INFO - Running setup.py (path:/tmp/pip-yR4EN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:00 INFO - Running setup.py (path:/tmp/pip-AEGsS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:00 INFO - Running setup.py (path:/tmp/pip-uvCdgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:00 INFO - Running setup.py (path:/tmp/pip-2VlGe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:00 INFO - Running setup.py (path:/tmp/pip-eDuNTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:00 INFO - Running setup.py (path:/tmp/pip-z8n7d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:00 INFO - Running setup.py (path:/tmp/pip-4FVsqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:00 INFO - Running setup.py (path:/tmp/pip-Zp1JWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:01 INFO - Running setup.py (path:/tmp/pip-Cul1Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:01 INFO - Running setup.py (path:/tmp/pip-RiHOlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:01 INFO - Running setup.py (path:/tmp/pip-eKRnPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:01 INFO - Running setup.py (path:/tmp/pip-GrpUFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:02:01 INFO - Running setup.py install for manifestparser 20:02:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:02:01 INFO - Running setup.py install for mozcrash 20:02:01 INFO - Running setup.py install for mozdebug 20:02:01 INFO - Running setup.py install for mozdevice 20:02:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:02:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:02:01 INFO - Running setup.py install for mozfile 20:02:01 INFO - Running setup.py install for mozhttpd 20:02:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:02:01 INFO - Running setup.py install for mozinfo 20:02:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:02:01 INFO - Running setup.py install for mozInstall 20:02:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Running setup.py install for mozleak 20:02:02 INFO - Running setup.py install for mozlog 20:02:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Running setup.py install for moznetwork 20:02:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Running setup.py install for mozprocess 20:02:02 INFO - Running setup.py install for mozprofile 20:02:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Running setup.py install for mozrunner 20:02:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:02:02 INFO - Running setup.py install for mozscreenshot 20:02:02 INFO - Running setup.py install for moztest 20:02:02 INFO - Running setup.py install for mozversion 20:02:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:02:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:02:03 INFO - Cleaning up... 20:02:03 INFO - Return code: 0 20:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:03 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:02:03 INFO - Using env: {'DISPLAY': ':0', 20:02:03 INFO - 'HOME': '/home/cltbld', 20:02:03 INFO - 'LANG': 'en_US.UTF-8', 20:02:03 INFO - 'LANGUAGE': 'en_US:en', 20:02:03 INFO - 'LOGNAME': 'cltbld', 20:02:03 INFO - 'MAIL': '/var/mail/cltbld', 20:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:03 INFO - 'MOZ_NO_REMOTE': '1', 20:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:03 INFO - 'NO_EM_RESTART': '1', 20:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:03 INFO - 'PWD': '/builds/slave/test', 20:02:03 INFO - 'SHELL': '/bin/bash', 20:02:03 INFO - 'SHLVL': '1', 20:02:03 INFO - 'TERM': 'linux', 20:02:03 INFO - 'TMOUT': '86400', 20:02:03 INFO - 'USER': 'cltbld', 20:02:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:03 INFO - '_': '/tools/buildbot/bin/python'} 20:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:02:03 INFO - Running setup.py (path:/tmp/pip-b6p9Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:02:03 INFO - Running setup.py (path:/tmp/pip-x6qH_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:02:03 INFO - Running setup.py (path:/tmp/pip-KbqmGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:02:03 INFO - Running setup.py (path:/tmp/pip-8QL717-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:02:03 INFO - Running setup.py (path:/tmp/pip-DqPYe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:02:03 INFO - Running setup.py (path:/tmp/pip-6CeKG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:02:03 INFO - Running setup.py (path:/tmp/pip-kkBmzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:02:03 INFO - Running setup.py (path:/tmp/pip-uLjPtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:02:03 INFO - Running setup.py (path:/tmp/pip-Ne4imJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:02:03 INFO - Running setup.py (path:/tmp/pip-ZGC28p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:02:04 INFO - Running setup.py (path:/tmp/pip-dx0BZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:02:04 INFO - Running setup.py (path:/tmp/pip-YRBnQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:02:04 INFO - Running setup.py (path:/tmp/pip-9CuOox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:02:04 INFO - Running setup.py (path:/tmp/pip-qi9Dd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:04 INFO - Running setup.py (path:/tmp/pip-5G1Qr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:02:04 INFO - Running setup.py (path:/tmp/pip-ITuzLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:02:04 INFO - Running setup.py (path:/tmp/pip-HfjEtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:02:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:06 INFO - Downloading blessings-1.6.tar.gz 20:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:02:06 INFO - Installing collected packages: blessings 20:02:06 INFO - Running setup.py install for blessings 20:02:06 INFO - Successfully installed blessings 20:02:06 INFO - Cleaning up... 20:02:06 INFO - Return code: 0 20:02:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:06 INFO - Reading from file tmpfile_stdout 20:02:06 INFO - Current package versions: 20:02:06 INFO - argparse == 1.2.1 20:02:06 INFO - blessings == 1.6 20:02:06 INFO - blobuploader == 1.2.4 20:02:06 INFO - docopt == 0.6.1 20:02:06 INFO - manifestparser == 1.1 20:02:06 INFO - mozInstall == 1.12 20:02:06 INFO - mozcrash == 0.17 20:02:06 INFO - mozdebug == 0.1 20:02:06 INFO - mozdevice == 0.48 20:02:06 INFO - mozfile == 1.2 20:02:06 INFO - mozhttpd == 0.7 20:02:06 INFO - mozinfo == 0.9 20:02:06 INFO - mozleak == 0.1 20:02:06 INFO - mozlog == 3.2 20:02:06 INFO - moznetwork == 0.27 20:02:06 INFO - mozprocess == 0.22 20:02:06 INFO - mozprofile == 0.28 20:02:06 INFO - mozrunner == 6.11 20:02:06 INFO - mozscreenshot == 0.1 20:02:06 INFO - mozsystemmonitor == 0.3 20:02:06 INFO - moztest == 0.7 20:02:06 INFO - mozversion == 1.4 20:02:06 INFO - psutil == 3.1.1 20:02:06 INFO - requests == 1.2.3 20:02:06 INFO - wsgiref == 0.1.2 20:02:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:06 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:02:06 INFO - Using env: {'DISPLAY': ':0', 20:02:06 INFO - 'HOME': '/home/cltbld', 20:02:06 INFO - 'LANG': 'en_US.UTF-8', 20:02:06 INFO - 'LANGUAGE': 'en_US:en', 20:02:06 INFO - 'LOGNAME': 'cltbld', 20:02:06 INFO - 'MAIL': '/var/mail/cltbld', 20:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:06 INFO - 'MOZ_NO_REMOTE': '1', 20:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:06 INFO - 'NO_EM_RESTART': '1', 20:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:06 INFO - 'PWD': '/builds/slave/test', 20:02:06 INFO - 'SHELL': '/bin/bash', 20:02:06 INFO - 'SHLVL': '1', 20:02:06 INFO - 'TERM': 'linux', 20:02:06 INFO - 'TMOUT': '86400', 20:02:06 INFO - 'USER': 'cltbld', 20:02:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:06 INFO - '_': '/tools/buildbot/bin/python'} 20:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:02:07 INFO - Cleaning up... 20:02:07 INFO - Return code: 0 20:02:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:07 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:02:07 INFO - Using env: {'DISPLAY': ':0', 20:02:07 INFO - 'HOME': '/home/cltbld', 20:02:07 INFO - 'LANG': 'en_US.UTF-8', 20:02:07 INFO - 'LANGUAGE': 'en_US:en', 20:02:07 INFO - 'LOGNAME': 'cltbld', 20:02:07 INFO - 'MAIL': '/var/mail/cltbld', 20:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:07 INFO - 'MOZ_NO_REMOTE': '1', 20:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:07 INFO - 'NO_EM_RESTART': '1', 20:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:07 INFO - 'PWD': '/builds/slave/test', 20:02:07 INFO - 'SHELL': '/bin/bash', 20:02:07 INFO - 'SHLVL': '1', 20:02:07 INFO - 'TERM': 'linux', 20:02:07 INFO - 'TMOUT': '86400', 20:02:07 INFO - 'USER': 'cltbld', 20:02:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:07 INFO - '_': '/tools/buildbot/bin/python'} 20:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:07 INFO - Downloading/unpacking jsonschema 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:02:09 INFO - Downloading/unpacking functools32 (from jsonschema) 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:09 INFO - Downloading functools32-3.2.3-2.tar.gz 20:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:02:09 INFO - warning: no files found matching '*.txt' 20:02:09 INFO - no previously-included directories found matching 'build' 20:02:09 INFO - no previously-included directories found matching 'dist' 20:02:09 INFO - no previously-included directories found matching '.git*' 20:02:09 INFO - Installing collected packages: jsonschema, functools32 20:02:09 INFO - Running setup.py install for functools32 20:02:09 INFO - warning: no files found matching '*.txt' 20:02:09 INFO - no previously-included directories found matching 'build' 20:02:09 INFO - no previously-included directories found matching 'dist' 20:02:09 INFO - no previously-included directories found matching '.git*' 20:02:09 INFO - Successfully installed jsonschema functools32 20:02:09 INFO - Cleaning up... 20:02:09 INFO - Return code: 0 20:02:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:02: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')]} 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02: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')]} 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:09 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 0x7f9520fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe21770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, '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': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:02:09 INFO - Using env: {'DISPLAY': ':0', 20:02:09 INFO - 'HOME': '/home/cltbld', 20:02:09 INFO - 'LANG': 'en_US.UTF-8', 20:02:09 INFO - 'LANGUAGE': 'en_US:en', 20:02:09 INFO - 'LOGNAME': 'cltbld', 20:02:09 INFO - 'MAIL': '/var/mail/cltbld', 20:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:09 INFO - 'MOZ_NO_REMOTE': '1', 20:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:09 INFO - 'NO_EM_RESTART': '1', 20:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:09 INFO - 'PWD': '/builds/slave/test', 20:02:09 INFO - 'SHELL': '/bin/bash', 20:02:09 INFO - 'SHLVL': '1', 20:02:09 INFO - 'TERM': 'linux', 20:02:09 INFO - 'TMOUT': '86400', 20:02:09 INFO - 'USER': 'cltbld', 20:02:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:09 INFO - '_': '/tools/buildbot/bin/python'} 20:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:09 INFO - Downloading/unpacking flake8 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:02:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:02:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:12 INFO - no previously-included directories found matching 'docs/_build' 20:02:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:02:12 INFO - Running setup.py install for pep8 20:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:02:12 INFO - no previously-included directories found matching 'docs/_build' 20:02:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:02:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:02:12 INFO - Cleaning up... 20:02:12 INFO - Return code: 0 20:02:12 INFO - Running post-action listener: _resource_record_post_action 20:02:12 INFO - Running post-action listener: _start_resource_monitoring 20:02:12 INFO - Starting resource monitoring. 20:02:12 INFO - ##### 20:02:12 INFO - ##### Finished create-virtualenv step (success) 20:02:12 INFO - ##### 20:02:12 INFO - ##### 20:02:12 INFO - ##### Running install step. 20:02:12 INFO - ##### 20:02:12 INFO - Running pre-action listener: _resource_record_pre_action 20:02:12 INFO - Running main action method: install 20:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:02:13 INFO - Reading from file tmpfile_stdout 20:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:02:13 INFO - Reading from file tmpfile_stdout 20:02:13 INFO - Output received: 20:02:13 INFO - Usage: mozinstall [options] installer 20:02:13 INFO - Options: 20:02:13 INFO - -h, --help show this help message and exit 20:02:13 INFO - -d DEST, --destination=DEST 20:02:13 INFO - Directory to install application into. [default: 20:02:13 INFO - "/builds/slave/test"] 20:02:13 INFO - --app=APP Application being installed. [default: firefox] 20:02:13 INFO - mkdir: /builds/slave/test/build/application 20:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:02:32 INFO - Reading from file tmpfile_stdout 20:02:32 INFO - Output received: 20:02:32 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:32 INFO - Running post-action listener: _resource_record_post_action 20:02:32 INFO - ##### 20:02:32 INFO - ##### Finished install step (success) 20:02:32 INFO - ##### 20:02:32 INFO - ##### 20:02:32 INFO - ##### Running run-tests step. 20:02:32 INFO - ##### 20:02:32 INFO - Running pre-action listener: _resource_record_pre_action 20:02:32 INFO - Running main action method: run_tests 20:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:32 INFO - Python 2.7.3 20:02:32 INFO - Return code: 0 20:02:32 INFO - grabbing minidump binary from tooltool 20:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb09c0>, '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 0xeb18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:02:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:02:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:02:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:32 INFO - Return code: 0 20:02:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:02:33 INFO - Return code: 0 20:02:33 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:02:33 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:02:33 INFO - Using env: {'DISPLAY': ':0', 20:02:33 INFO - 'HOME': '/home/cltbld', 20:02:33 INFO - 'LANG': 'en_US.UTF-8', 20:02:33 INFO - 'LANGUAGE': 'en_US:en', 20:02:33 INFO - 'LOGNAME': 'cltbld', 20:02:33 INFO - 'MAIL': '/var/mail/cltbld', 20:02:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:33 INFO - 'MOZ_NO_REMOTE': '1', 20:02:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:33 INFO - 'NO_EM_RESTART': '1', 20:02:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:33 INFO - 'PWD': '/builds/slave/test', 20:02:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:33 INFO - 'SHELL': '/bin/bash', 20:02:33 INFO - 'SHLVL': '1', 20:02:33 INFO - 'TERM': 'linux', 20:02:33 INFO - 'TMOUT': '86400', 20:02:33 INFO - 'USER': 'cltbld', 20:02:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791', 20:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:33 INFO - '_': '/tools/buildbot/bin/python'} 20:02:33 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:02:33 INFO - mozversion application_buildid: 20160530173007 20:02:33 INFO - mozversion application_changeset: 3a87296fe4145138c2ce15512bb31f76fe869cb4 20:02:33 INFO - mozversion application_display_name: Nightly 20:02:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:33 INFO - mozversion application_name: Firefox 20:02:33 INFO - mozversion application_remotingname: firefox 20:02:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:33 INFO - mozversion application_vendor: Mozilla 20:02:33 INFO - mozversion application_version: 49.0a1 20:02:33 INFO - mozversion platform_buildid: 20160530173007 20:02:33 INFO - mozversion platform_changeset: 3a87296fe4145138c2ce15512bb31f76fe869cb4 20:02:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:33 INFO - mozversion platform_version: 49.0a1 20:02:33 INFO - using testdate: 1464663753 20:02:33 INFO - actual date: 1464663753 20:02:33 INFO - starting webserver on 'localhost:45400' 20:02:33 INFO - SUITE-START | Running 2 tests 20:02:33 INFO - TEST-START | dromaeo_css 20:02:33 INFO - operating with platform_type : linux_ 20:02:33 INFO - Initialising browser for dromaeo_css test... 20:02:33 INFO - TEST-INFO | started process 25459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkorDQ/profile http://localhost:45400/getInfo.html) 20:02:39 INFO - PROCESS | 25459 | __metrics Screen width/height:1600/1200 20:02:39 INFO - PROCESS | 25459 | colorDepth:24 20:02:39 INFO - PROCESS | 25459 | Browser inner width/height: 1024/697 20:02:39 INFO - PROCESS | 25459 | __metrics 20:02:40 ERROR - PROCESS | 25459 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:02:40 INFO - PROCESS | 25459 | console.error: PushService: 20:02:40 INFO - PROCESS | 25459 | stateChangeProcessEnqueue: Error transitioning state 20:02:40 INFO - PROCESS | 25459 | UnknownError 20:02:41 INFO - TEST-INFO | 25459: exit 0 20:02:41 INFO - Browser initialized. 20:02:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:41 INFO - TEST-INFO | started process 25541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkorDQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:53 INFO - PROCESS | 25541 | RSS: Main: 154902528 20:02:53 INFO - PROCESS | 25541 | 20:03:44 INFO - PROCESS | 25541 | 1464663824298 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:05:52 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45400/tests/dromaeo/cssquery-ext.html) 20:05:53 INFO - PROCESS | 25541 | RSS: Main: 241848320 20:05:53 INFO - PROCESS | 25541 | 20:08:56 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-ext.html (next: http://localhost:45400/tests/dromaeo/cssquery-jquery.html) 20:08:56 INFO - PROCESS | 25541 | RSS: Main: 235995136 20:08:56 INFO - PROCESS | 25541 | 20:11:58 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45400/tests/dromaeo/cssquery-mootools.html) 20:11:59 INFO - PROCESS | 25541 | RSS: Main: 244125696 20:11:59 INFO - PROCESS | 25541 | 20:15:01 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45400/tests/dromaeo/cssquery-prototype.html) 20:15:01 INFO - PROCESS | 25541 | RSS: Main: 233295872 20:15:01 INFO - PROCESS | 25541 | 20:18:04 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45400/tests/dromaeo/cssquery-yui.html) 20:18:05 INFO - PROCESS | 25541 | RSS: Main: 208744448 20:18:05 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | Cycle 1(1): loaded http://localhost:45400/tests/dromaeo/cssquery-yui.html (next: http://localhost:45400/tests/dromaeo/cssquery-dojo.html) 20:21:07 INFO - PROCESS | 25541 | RSS: Main: 272580608 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | __start_tp_report 20:21:07 INFO - PROCESS | 25541 | _x_x_mozilla_page_load 20:21:07 INFO - PROCESS | 25541 | _x_x_mozilla_page_load_details 20:21:07 INFO - PROCESS | 25541 | |i|pagename|runs| 20:21:07 INFO - PROCESS | 25541 | |0;dojo.html;3107.4561951658457;3120.765942554309;3122.203838021305;3162.241062145083;3179.4753865612174;5183.559397451221;5259.76331065102;5294.497022782839;5330.253764472972;5354.437784032674;5251.2385704072885;5267.52592266696;5274.551663108631;5279.868003299919;5323.707196104213;4765.094632019923;4829.4687584365865;4851.805927762885;4856.247281671346;5008.724520151391;4918.262260660894;4979.676321039139;4986.825461108862;4991.850244492671;5007.949920500785;4662.323963025359;4797;4825.662203645747;4853.369062021915;4860.125177468054;4828.758562071917;4832;4854.878628034292;4866.635002374801;4897.730624815634;4828.420589529243;4830.082284365959;4847.757612119415;4861.927071093936;4874.098291816025;5087.516685914869;5162.432132465426;5205.037068142406;5312.814051508179;5319.20211968204;5745.827625171251;5754.942450575482;5758.971205143989;5760.164776107483;5768.019436695772;5491.2312276281355;5750.05124154514;5796.478316951452;5801.970990145022;5810.1865738796605;5278.9208161877605;5337.786488540453;5342.706151161685;5399.7030163341;5405.648632838853;5849.912251316234;5861.912071318934;5872.442117998783;5881.911771323434;5895.67573783446;5411.377691565442;5494.725263736797;5651.80218692352;5656.830295091154;5663.235463212496;5613.382527921925;5664.26364572603;5677.318721753333;5678.886422271531;5680.517156041783;5601.327840659147;5633.492985631313;5644.3508996465935;5648.576356773258;5655.575831812548;5432.91850622241;5574.498295153456;5606;5651.434856514398;5667.659940403589;4328.091100868853;4337.522872484024;4339.045410009793;4374.934375984363;4375.518692943773;3851.2490064437725;3861.8069096545623;3885.2812229737024;3912.882613521599;3916.2754890345377;5236.92144617831;5238.161894097002;5380.381256155514;5384.030874442559;5428.809991650273;5720.685362305113;5748.425157484218;5753.597248192586;5773.566982476331;5804.2744656917885;5478.780848766084;5487.42382049887;5490.066688662937;5493.505584497414;5496.285482887279;4844.563989240985;4936.975315123474;4940.901181976412;4977.427595826454;5028.472010438924;6001.5798894077;6005.549583781234;6018.8194354169445;6024.909626355608;6049.213602231682;5760.884782304414;5761.740721667619;5763.193152958505;5765.4811067004175;5770.682612456355;5749.683767392834;5916.171735957056;5919.378465261086;5995.430434108753;6006.639601623917;5617.213590097308;5634.830955071355;5651.915221271602;5655.123455864347;5673.8297851064535;5742.483176514133;5756.309242890712;5760.510356619734;5763.308402991668;5772.422757724194;5375.704336261543;5538.806141785019;5568.721563921868;5590.720463976703;5600.775968961196;5586.1062230043;5595.888082238251;5596.692181930033;5600.0479918414785;5601.6358936668985;5482.671039737628;5496.917546236889;5502.504774570308;5503.7798488060025;5548.167774833807;5420.186971954238;5529.889402212014;5586.1062230043;5598.3282006159525;5685.630434021776;5465.316835395575;5502.862428439321;5503.972480137573;5506.531944784738;5549.500544950974 20:21:07 INFO - PROCESS | 25541 | |1;ext.html;607.4259824465881;613.7330261336319;641.4163111568473;645.799802061361;656.6060363781728;31778;32339.51490727638;43530.99999999996;44089.11821763563;44213;45491.54508454914;45736.08527829441;46033.53966460334;46058;46080.76959615206;8520.06279309277;8682.30541556674;8732.476051436903;8740.257078148334;8748.431351962134;8747.169018943223;8863.556822158866;8877.112288771135;8879.200871921526;8893.333000025024;8933.910660893373;8965.596548155349;8967.506787126706;8995.775105622379;9004.279657627374;8889.066648001964;8892.644294228223;8901.955490222572;8906.198442140238;8948.284137269035;8769.649214031431;8862.202401783807;8862.689805856828;8867.778305542348;8867.955660221722;40613.39079913804;40870.38694419556;41064.79467602643;41092.178156437;41315;3232.6282477514915;3251.5772949516413;3353.7024259241707;3472.808995505246;3628.7097032237357;32008.679913201035;32528.674713253036;33052.33895322104;33917.83041084779;34044.14889627754;4221.02916329246;4285.1429714057;4307;4336.457942757155;4355.237833379146;326866;327555.9999999976;327619;327981;328833;58868.41131588715;58973.70513147407;59239.70380148072;59330.703346482995;59420.40579594235;59614.403855961755;60422;61638.38361616416;62386.68806656029;62548;15797.447089351817;16148;16161.919190404207;16163.191840407933;16213.756793648105;12824.140499627501;12845.678858028625;12924.870751292367;12931.870681293067;12942.158759680591;16097.585362195765;17104.572385690208;17326.913365433345;17418.39035633772;17716.20277087534;6001.879962400815;6019.138182471986;6027.45752882234;6085.6348619083;6098.237720284965;945.2201933404968;1026.743314171457;1059.2161800267747;1117.983230251547;1156.9305841649527;32231.838840805645;32826.83586582052;33208.833955830065;33210.83394583012;33781.324373512885;1130.2879186112696;1148.4315263944234;1150.7813515432208;1168.9707757306135;1180.1738782851867;17054.14729263532;17353.65292694139;17421.738673919903;17435.47693569195;17492.5626859327;517131;523258;524749;525329;525929;56081.158782618295;57002.714986425635;57112.42887571071;57312.713436432554;57351.13973290404;1234.4383305595932;1320.7160460500845;1359.2795818216362;1366.3168415792104;1393.9721205576034;31171.532427014066;33499.49750753692;33539.329213415105;33609.99170024903;33966.83016585;44216.55783442253;44646.3303050461;44672.10655786931;44704.32943505785;44709.329360058975;393666;400898;401296;402233;402332;35291.470627940085;40325;41114.588854111076;42295.15409691851;44627;47249.52750472589;47312;47796.761016194694;48130.51869481261;48349;39512;40773.38839917344;41504.377434337905;41530.37704434375;43412.78293608512;41164.794176028925;41485.1702965945;42307.7884610575;42378.36432453454;42499.5750042508;42041.57958420377;42310.57689423066;42812.571874282105;42975.57024429716;43088.569114308455;35450;36962.26075478529;37331.81334093312;37429;37605.81197093997;28285.43429131447;28380.85809570939;28434.57348139821;28521.42957140887;28695 20:21:07 INFO - PROCESS | 25541 | |2;jquery.html;379.3532027892444;381.5650158818945;396.80754833905553;402.5531659857556;413.10562631901934;18418.355357562486;19092.33176838811;19880.602387952233;19881.50296242593;19881.701774473375;16890.83109168908;17362.739558906625;17606.735898961495;17767.733483997752;17795.110244487787;3994.400839874013;5204.739763011844;5579.13523403873;5597.832065038035;5604.915926261109;5018.623603229754;6229.314775374705;6234.563580549363;6236.968815155918;6237.781677641284;5417.133258678612;6069.1806606108275;6251.624902505864;6260.342664020281;6263.185785847856;3834.9041273968232;5605.831825045255;5792.449717276873;6856.485763567753;7257.274272572753;6857.862842743117;7050.647467626598;7133.500654954155;7173.533720308215;7174.246704096047;25176.118835840658;25782.226533204033;26166.6075008875;26173.607395889077;26178.345541361618;2448.375664205634;2571.4085760275243;2634.5916382960672;2833.3058400691757;3334.549835772164;14546.70906581873;15547.766783498257;15579;15912.363505459767;16185.595360115973;2015.5968806238811;2048.3240530624857;2097.2345094040716;2159.6436587962967;2240.0703707961175;87723.56138219268;89050.55474722585;91318;92007;93545.53227233888;17089.48731538056;17478.30086796514;17480;17611;17750.46748597544;31371.3922898865;31423.84288078545;31851.681483185333;31871.88448404295;31979.200519987186;9213.309001824757;9644.373115747454;9648.276379271583;9658.179054780423;9736.902630973742;7927.207279272026;8051.074126475531;8144.918550814416;8154.3884208684585;8156.143604921516;8772.868406973901;8878.556072196365;8906.064863189402;8926.464412135163;9171.40385874916;3232.095013396253;3260.250142467246;3397.6092749333648;3439.9828000859834;3616.5298511193378;862.5730263519598;997.8602995580625;1005.7485628592851;1072.51736718477;1139.549877798265;18051.909740451214;18554.536136596693;20348.18607255723;20434.182632694527;20489.795102049087;1032.2516175772655;1085.9565617375374;1087.456271864068;1088.9128869690405;1091.0780390569955;10334.896651033543;10432.530536125741;10753.301035432829;11202.831957520644;11447.198696091195;195499;195518;195581;196327;196647;90019;95562.52218739002;96485.51757241169;96754.03245967592;97331;1049.223574554824;1082.2802836113897;1082.5290998415715;1091.792559413709;1101.5208384352832;17303.826961730727;17344.219510121824;17551.122443878012;17564.91217543904;17745.91127044408;37138.25723485569;37158.6284137166;40353.25951294524;40514.59485405226;41035.794821026895;52901.735491322295;53642.73178634238;53918.19122713241;54569.181462278895;56334.7183264081;8501.702440414556;8532.786680332792;8600.268977137013;8621.827563448822;8638;8034.116247212685;9619.855702164334;12053.75892482163;13558.661033474242;13584.796228056784;11289.266197697123;11745.588904388305;11824.113191510844;11895.583654572049;12199.390030498262;5682.886342273214;10728.356298622108;11637;11688.123390745897;11919;6552.737890484518;10635.734106647396;11017;11813.350265735467;12063.638090857288;8632.266257367943;8674.913250867663;8750.868736968823;8970.86543701832;8993.28053755711;11028.779424411627;11797.705057373634;11903.583374581847;12212.389380531116;12328.321942292901 20:21:07 INFO - PROCESS | 25541 | |3;mootools.html;1346.8922486201093;1514.2504460292157;1531.961700957476;1697.74533819927;1816.5095424235449;8066.71766488173;8375.455595386304;8385.87421188682;8627.180417860309;8637.870431943526;8339.291160251385;8557.91442085579;8562.357823163256;8562.957185214082;8563.65745370186;2014.9798502015012;2083.874967501947;2085.624587574236;2335.7781010803947;2366.503034362786;2317.2353123469297;2417.226487523993;2419.8427102238297;2429.4047958250167;2431.598786200275;2284.326123793485;2304.8156147508157;2310.4108452344713;2319.1766922742354;2327.6159433693506;1963.9018049097488;2233.452804063015;2292.793648571628;2327.2320134355623;2328.0571368595747;2327.3483424641126;2366.183666635008;2366.8816559171973;2368.1948137633117;2369.644553316999;8459.95770021152;8512.70205542803;8515.403921725481;8521.659133634646;8522.48865068098;4839.879003024953;4959.082569724576;4973.079980203674;4975;4975.552200301954;3101.6743241959493;3267.591551056118;3408.216110294621;3413.812240326781;3420.0936751760805;1136.7101389145798;1138.3170097941252;1146.72478605135;1161.9593314234046;1166.7958107331183;11747.94126029373;11765.705857353549;11773.352465614387;11773.411329433495;11791.528338866521;4488.887777805581;4515.435570553681;4591.701539399928;4591.9438529137815;4663.953360466352;10011.79976400468;10017.298789084694;10019.599216031276;10022.298439109192;10030.598776049022;5041.092603331435;5106.514881086291;5107.259447380109;5111.156659151273;5112.974435127875;3899.415087736862;4467.5755803198645;4648.372469716613;4707.62339012885;4711.505291944365;3918.45141680165;3960.7227494075714;4057.634812866856;4106.137711080647;4110.486189226347;1283.0505425984704;1288.0854593238719;1293.8188653588504;1301.537954026307;1312.553731731216;883.9779005524784;915.9969833032818;952.1002652493328;983.6753871222622;986.9636881274633;5594.0769772987815;5594.832155035356;5772.134179873053;5788.652680839163;5866.941330586725;459.48996613758703;470.37440204527894;479.2380115616187;486.56938609330996;487.1085912779605;4162.7502349859105;4175.185838761412;4182.665386769051;4201.537830838605;4230.661547076226;9986.900130998598;10334.793304133875;10423.530941107669;10437.739056523496;10440.321379110334;10256.230782691327;10318.329308594917;10327.277090603737;10337.276390652582;10337.9483102584;7519;7721.343685786771;7806.68773249075;7819.5699236541395;7831.725889593837;5954.523638108854;5958.6424814511265;5961.105834124916;6128.479079278133;6214.471769899609;9427.15155635996;9806.950965245129;9814.312998090065;9818.509074546388;9820.214382849497;9482.620695172116;9634.662786802428;9769.951150244204;9830.803383932423;9839.754006149904;6885.586864788129;7304.890426643711;7465.141508726349;7593.772186834404;7766.728164514215;8152.184781521801;8168.591570421337;8192.467489613156;8230.876536852073;8240.876386854083;6955.23492415844;7036.929630703832;7091.042709234393;7196.316349946746;7272.709091636275;7226.7109315626785;7231.8553628928175;7248.238934911758;7358.374538164316;7406.888896666446;6675.4325882300545;6739;6746.595204287759;6750.1562304711915;6751.122354093936;4950.133726597759;5087.465816089258;5136.332276803992;5154.5103215194495;5167.92248116271;5064.265681476239;5223.9477605223465;5224.947750522446;5249.527542521191;5285.7621407036 20:21:07 INFO - PROCESS | 25541 | |4;prototype.html;312.4376122978638;320.2649918437187;330.4893938864455;331.14894720568134;332.1811734075503;5130.769115389807;5250.684958902469;5259.289995850559;5340.946590534093;5364.007658583165;5243.659162154467;5258.55302299305;5272.657277276974;5279.472052794718;5306.310179676646;4147.755673297998;4148.377743338493;4154.667626589866;4156.792160391976;4199.517055538621;3893.9415908761393;3943.487346644932;4148.522919864209;4174.519930208019;4177.1829254274335;4138.172365526892;4139.544650088488;4139.917201655965;4143.694736158101;4157.750534967897;4144.399062135988;4149.751014939098;4152.27335216339;4156.958430415687;4188.832446702128;3471.6354782747953;3702.778083232527;3722.7952462614544;3723.5345581802276;3724.2179142380132;5092.3125378073855;5145.228215767665;5164.741762911839;5166.121759300928;5176.5858731301405;4700.929486057712;4721;4730.172219861511;4732.337472753818;4756.952430475721;5439.782408703647;5535.778568857241;5602.523785478239;5608.4111168327145;5622.718864056781;3940.271049855786;3949.2891279569667;3971.0415740273393;3973.2450834341385;3986.3223252046932;5828.679422631796;5871.911921321183;5881.529477641821;5882.3529411764675;5924.792632257893;3831;3953.031507280735;3961.8415263389143;3963.147923196527;3979;3950.7036972226624;3980.24375368679;3982.2433737590345;3989.0625702959783;4010.1578668479947;4596.195665758479;4627.305904114342;4632.5135860734135;4678.345031695565;4689.249720044844;5536.944630553723;5539.723013849291;5673.092305231144;5676.148577713376;5725.8568535786935;1360.6394305509048;1410.3371415434729;1421.5664222412263;1423.8932080094035;1430.8497607751244;895.9417637853519;896.1173244354305;912.1334732004622;918.4030380252756;918.807050519385;4690.170833374987;4843.529799802126;4932.55606995365;4940.555350018443;4953.885375790491;5042.268871013755;5050.520200580939;5115.951229997841;5118.564921981599;5121.564667003272;4804.903901921942;4881.560659540658;4887.902241955141;4937.35814344133;5120.359955005624;3042.2242328206607;3056.3734434440885;3067.662557118715;3067.8159310441447;3071.293602471444;5929.703514824328;5962.701864906738;5970.671613061237;5995.092380195601;6009.128676341906;5549.472800083986;5810.680412577264;5818.883622327529;5821.544613846539;5830.591858569859;5940.752441987144;6004.519638428916;6029.457348838538;6044.969775151096;6049.729556793035;5548.472895075123;5777.22007528995;5800.4489573490455;5808.82573522795;5814.854628634318;5682.346530149086;5698.515626171822;5726.795183854163;5736.311642602915;5741.224934633938;5985.700714964321;6006.489448396936;6014.218151640259;6023.939760602338;6041.78853740117;3904.472896158982;3966.2464131814863;4041.131156801302;4049.9595004049584;4051.372037334218;5768.6538807669995;5774.624649397776;5792.131180322816;5796.188533605215;5816.796412125555;5536.307961504812;5657.519110875622;5669.376368599534;5669.716514174357;5688.914666279927;5488.313960754906;5546.611737178358;5546.833594992157;5552.69460179694;5574.832755017356;5427.778749781425;5444.352283969671;5447.237386765777;5452.754626041917;5458.699771512446;5326.493983071602;5585.497305242548;5601.719914004202;5639.661620302795;5681.659100453986;5556.805286863344;5564.38791732901;5572.164175373727;5585.96659617972;5609.429359779268 20:21:07 INFO - PROCESS | 25541 | |5;yui.html;704.6018999265416;737.3437640499956;771.7954741993371;776.7786180938434;828.697525403228;13656.52202172924;14030;14348.784768228485;14409.135451872895;14459.13245205287;14472.5658230253;14550.19973901435;14551.27243637819;14573.635659108528;14582.562523124298;673.599208470959;690.8238399208195;691.6749127909874;795.936325093994;810.4853418079532;693.3101563943883;782.85517179322;809.1261437647356;816.7263966571206;817.8854960305562;853.2875049333783;853.9914600853974;854.5171977832505;855.2730179347536;855.9899318803809;696.6377483708443;848.4781859156606;848.8005318750089;849.9532525711084;850.0649285785618;602.6504627316147;615.6275453350748;616.300498933709;621.5711159300068;621.9751209951596;13021.479140834355;13107;13127.671808204776;13133.86866131336;13185.142965707199;13440.260785656785;13766.105203161762;13766.449342026306;13921.443142274296;14109.576712698636;12174.5738899139;12507.687307817287;12585.622431327074;12596.691687378821;12662.81005784914;4465.10697860426;4487.775611219426;4531.478879928784;4531.614812740921;4675.7895894684825;58300.416995829924;58589.707051464895;58967.70516147435;58979.11531327033;59415.40584594142;10302.433366164933;10821.891781082088;11177.329360238411;11217.270877393106;11231.719207019727;20256.49358766013;20311.28910488126;20337.186512539334;20341.186352545734;20374.28689995843;8342.833143337099;8517.23344898962;8675.349348798865;8705.564721763887;8957.865632015524;4684.547046364271;4707.741074240949;4727.2909063640045;4794.328793968847;4863.2461968394955;3374.6794054564775;3475.5134281200653;3476.165720227127;3479.2693534357563;3493.3013397320638;614.6281499692711;623.3766233766233;628.1739512541085;638.1894993358409;641.3169973977699;645.2321737132891;666.9199696036507;687.2920891481682;745.5899255409503;770.5936665585217;9010.27917766577;9300.863630240588;9361.906380936103;9372.437653740797;9535.189508891683;623.5884316351187;645.4094503529312;740.5408646639011;743.7396911081079;756.6519401075567;4245.405643209953;4462.397576327219;4508.233600287959;4524.524924882906;4582.373257493542;61908;63352.36647633557;65824.67087664627;66374;66515;56947.71526142343;57733.42266577281;58468.415315847145;58711.412885870595;59892.401075989554;53337.73331133397;53426;53971.46028539664;54869.72565137229;55678.72160639171;8197.877031844408;8222.588870556328;8465.238128568459;8593.52735599548;8878.378513503993;36855.26289474249;37282.25435491329;37334.62665373312;38087.80956095202;38766.4185037219;47868;49597.75201123971;49966.25050624171;49986.25020624766;50222.246666300765;10666.73333166677;10827.729306767395;10933.890661093288;11120.867128010645;11343.432828358715;12352.135350525377;12356.21465976399;12461.439235234255;12534.373281335715;12543.93728031354;11412.201145920038;11591.826122608;11707.88292117102;11767.823482647596;12188.817167742669;12148.817767733315;12410.5656302029;12436.19164754288;12447.128700991207;12854.485820567073;11714.531418743496;11747.823782643438;11755;11965.940170299093;12066.396680166132;10457.529411176667;10616.1507079435;10669.146468282364;10691.411972341595;10763.67708968701;9655.758606034906;9778;9966.750831229278;10066.949665251626;10333.638322658671 20:21:07 INFO - PROCESS | 25541 | __end_tp_report 20:21:07 INFO - PROCESS | 25541 | __start_cc_report 20:21:07 INFO - PROCESS | 25541 | _x_x_mozilla_cycle_collect,1021 20:21:07 INFO - PROCESS | 25541 | __end_cc_report 20:21:07 INFO - PROCESS | 25541 | __startTimestamp1464664867952__endTimestamp 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | ------- Summary: start ------- 20:21:07 INFO - PROCESS | 25541 | Number of tests: 6 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#0] dojo.html Cycles:165 Average:5303.57 Median:5496.29 stddev:601.65 (10.9%) stddev-sans-first:578.30 20:21:07 INFO - PROCESS | 25541 | Values: 3107.5 3120.8 3122.2 3162.2 3179.5 5183.6 5259.8 5294.5 5330.3 5354.4 5251.2 5267.5 5274.6 5279.9 5323.7 4765.1 4829.5 4851.8 4856.2 5008.7 4918.3 4979.7 4986.8 4991.9 5007.9 4662.3 4797.0 4825.7 4853.4 4860.1 4828.8 4832.0 4854.9 4866.6 4897.7 4828.4 4830.1 4847.8 4861.9 4874.1 5087.5 5162.4 5205.0 5312.8 5319.2 5745.8 5754.9 5759.0 5760.2 5768.0 5491.2 5750.1 5796.5 5802.0 5810.2 5278.9 5337.8 5342.7 5399.7 5405.6 5849.9 5861.9 5872.4 5881.9 5895.7 5411.4 5494.7 5651.8 5656.8 5663.2 5613.4 5664.3 5677.3 5678.9 5680.5 5601.3 5633.5 5644.4 5648.6 5655.6 5432.9 5574.5 5606.0 5651.4 5667.7 4328.1 4337.5 4339.0 4374.9 4375.5 3851.2 3861.8 3885.3 3912.9 3916.3 5236.9 5238.2 5380.4 5384.0 5428.8 5720.7 5748.4 5753.6 5773.6 5804.3 5478.8 5487.4 5490.1 5493.5 5496.3 4844.6 4937.0 4940.9 4977.4 5028.5 6001.6 6005.5 6018.8 6024.9 6049.2 5760.9 5761.7 5763.2 5765.5 5770.7 5749.7 5916.2 5919.4 5995.4 6006.6 5617.2 5634.8 5651.9 5655.1 5673.8 5742.5 5756.3 5760.5 5763.3 5772.4 5375.7 5538.8 5568.7 5590.7 5600.8 5586.1 5595.9 5596.7 5600.0 5601.6 5482.7 5496.9 5502.5 5503.8 5548.2 5420.2 5529.9 5586.1 5598.3 5685.6 5465.3 5502.9 5504.0 5506.5 5549.5 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#1] ext.html Cycles:180 Average:58447.29 Median:23131.30 stddev:112414.96 (486.0%) stddev-sans-first:112646.43 20:21:07 INFO - PROCESS | 25541 | Values: 607.4 613.7 641.4 645.8 656.6 31778.0 32339.5 43531.0 44089.1 44213.0 45491.5 45736.1 46033.5 46058.0 46080.8 8520.1 8682.3 8732.5 8740.3 8748.4 8747.2 8863.6 8877.1 8879.2 8893.3 8933.9 8965.6 8967.5 8995.8 9004.3 8889.1 8892.6 8902.0 8906.2 8948.3 8769.6 8862.2 8862.7 8867.8 8868.0 40613.4 40870.4 41064.8 41092.2 41315.0 3232.6 3251.6 3353.7 3472.8 3628.7 32008.7 32528.7 33052.3 33917.8 34044.1 4221.0 4285.1 4307.0 4336.5 4355.2 326866.0 327556.0 327619.0 327981.0 328833.0 58868.4 58973.7 59239.7 59330.7 59420.4 59614.4 60422.0 61638.4 62386.7 62548.0 15797.4 16148.0 16161.9 16163.2 16213.8 12824.1 12845.7 12924.9 12931.9 12942.2 16097.6 17104.6 17326.9 17418.4 17716.2 6001.9 6019.1 6027.5 6085.6 6098.2 945.2 1026.7 1059.2 1118.0 1156.9 32231.8 32826.8 33208.8 33210.8 33781.3 1130.3 1148.4 1150.8 1169.0 1180.2 17054.1 17353.7 17421.7 17435.5 17492.6 517131.0 523258.0 524749.0 525329.0 525929.0 56081.2 57002.7 57112.4 57312.7 57351.1 1234.4 1320.7 1359.3 1366.3 1394.0 31171.5 33499.5 33539.3 33610.0 33966.8 44216.6 44646.3 44672.1 44704.3 44709.3 393666.0 400898.0 401296.0 402233.0 402332.0 35291.5 40325.0 41114.6 42295.2 44627.0 47249.5 47312.0 47796.8 48130.5 48349.0 39512.0 40773.4 41504.4 41530.4 43412.8 41164.8 41485.2 42307.8 42378.4 42499.6 42041.6 42310.6 42812.6 42975.6 43088.6 35450.0 36962.3 37331.8 37429.0 37605.8 28285.4 28380.9 28434.6 28521.4 28695.0 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#2] jquery.html Cycles:180 Average:22017.00 Median:31861.78 stddev:36498.03 (114.6%) stddev-sans-first:36564.26 20:21:07 INFO - PROCESS | 25541 | Values: 379.4 381.6 396.8 402.6 413.1 18418.4 19092.3 19880.6 19881.5 19881.7 16890.8 17362.7 17606.7 17767.7 17795.1 3994.4 5204.7 5579.1 5597.8 5604.9 5018.6 6229.3 6234.6 6237.0 6237.8 5417.1 6069.2 6251.6 6260.3 6263.2 3834.9 5605.8 5792.4 6856.5 7257.3 6857.9 7050.6 7133.5 7173.5 7174.2 25176.1 25782.2 26166.6 26173.6 26178.3 2448.4 2571.4 2634.6 2833.3 3334.5 14546.7 15547.8 15579.0 15912.4 16185.6 2015.6 2048.3 2097.2 2159.6 2240.1 87723.6 89050.6 91318.0 92007.0 93545.5 17089.5 17478.3 17480.0 17611.0 17750.5 31371.4 31423.8 31851.7 31871.9 31979.2 9213.3 9644.4 9648.3 9658.2 9736.9 7927.2 8051.1 8144.9 8154.4 8156.1 8772.9 8878.6 8906.1 8926.5 9171.4 3232.1 3260.3 3397.6 3440.0 3616.5 862.6 997.9 1005.7 1072.5 1139.5 18051.9 18554.5 20348.2 20434.2 20489.8 1032.3 1086.0 1087.5 1088.9 1091.1 10334.9 10432.5 10753.3 11202.8 11447.2 195499.0 195518.0 195581.0 196327.0 196647.0 90019.0 95562.5 96485.5 96754.0 97331.0 1049.2 1082.3 1082.5 1091.8 1101.5 17303.8 17344.2 17551.1 17564.9 17745.9 37138.3 37158.6 40353.3 40514.6 41035.8 52901.7 53642.7 53918.2 54569.2 56334.7 8501.7 8532.8 8600.3 8621.8 8638.0 8034.1 9619.9 12053.8 13558.7 13584.8 11289.3 11745.6 11824.1 11895.6 12199.4 5682.9 10728.4 11637.0 11688.1 11919.0 6552.7 10635.7 11017.0 11813.4 12063.6 8632.3 8674.9 8750.9 8970.9 8993.3 11028.8 11797.7 11903.6 12212.4 12328.3 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#3] mootools.html Cycles:180 Average:5595.64 Median:4954.61 stddev:3139.43 (63.4%) stddev-sans-first:3131.99 20:21:07 INFO - PROCESS | 25541 | Values: 1346.9 1514.3 1532.0 1697.7 1816.5 8066.7 8375.5 8385.9 8627.2 8637.9 8339.3 8557.9 8562.4 8563.0 8563.7 2015.0 2083.9 2085.6 2335.8 2366.5 2317.2 2417.2 2419.8 2429.4 2431.6 2284.3 2304.8 2310.4 2319.2 2327.6 1963.9 2233.5 2292.8 2327.2 2328.1 2327.3 2366.2 2366.9 2368.2 2369.6 8460.0 8512.7 8515.4 8521.7 8522.5 4839.9 4959.1 4973.1 4975.0 4975.6 3101.7 3267.6 3408.2 3413.8 3420.1 1136.7 1138.3 1146.7 1162.0 1166.8 11747.9 11765.7 11773.4 11773.4 11791.5 4488.9 4515.4 4591.7 4591.9 4664.0 10011.8 10017.3 10019.6 10022.3 10030.6 5041.1 5106.5 5107.3 5111.2 5113.0 3899.4 4467.6 4648.4 4707.6 4711.5 3918.5 3960.7 4057.6 4106.1 4110.5 1283.1 1288.1 1293.8 1301.5 1312.6 884.0 916.0 952.1 983.7 987.0 5594.1 5594.8 5772.1 5788.7 5866.9 459.5 470.4 479.2 486.6 487.1 4162.8 4175.2 4182.7 4201.5 4230.7 9986.9 10334.8 10423.5 10437.7 10440.3 10256.2 10318.3 10327.3 10337.3 10337.9 7519.0 7721.3 7806.7 7819.6 7831.7 5954.5 5958.6 5961.1 6128.5 6214.5 9427.2 9807.0 9814.3 9818.5 9820.2 9482.6 9634.7 9770.0 9830.8 9839.8 6885.6 7304.9 7465.1 7593.8 7766.7 8152.2 8168.6 8192.5 8230.9 8240.9 6955.2 7036.9 7091.0 7196.3 7272.7 7226.7 7231.9 7248.2 7358.4 7406.9 6675.4 6739.0 6746.6 6750.2 6751.1 4950.1 5087.5 5136.3 5154.5 5167.9 5064.3 5223.9 5224.9 5249.5 5285.8 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#4] prototype.html Cycles:180 Average:4655.96 Median:5210.12 stddev:1386.92 (26.6%) stddev-sans-first:1351.95 20:21:07 INFO - PROCESS | 25541 | Values: 312.4 320.3 330.5 331.1 332.2 5130.8 5250.7 5259.3 5340.9 5364.0 5243.7 5258.6 5272.7 5279.5 5306.3 4147.8 4148.4 4154.7 4156.8 4199.5 3893.9 3943.5 4148.5 4174.5 4177.2 4138.2 4139.5 4139.9 4143.7 4157.8 4144.4 4149.8 4152.3 4157.0 4188.8 3471.6 3702.8 3722.8 3723.5 3724.2 5092.3 5145.2 5164.7 5166.1 5176.6 4700.9 4721.0 4730.2 4732.3 4757.0 5439.8 5535.8 5602.5 5608.4 5622.7 3940.3 3949.3 3971.0 3973.2 3986.3 5828.7 5871.9 5881.5 5882.4 5924.8 3831.0 3953.0 3961.8 3963.1 3979.0 3950.7 3980.2 3982.2 3989.1 4010.2 4596.2 4627.3 4632.5 4678.3 4689.2 5536.9 5539.7 5673.1 5676.1 5725.9 1360.6 1410.3 1421.6 1423.9 1430.8 895.9 896.1 912.1 918.4 918.8 4690.2 4843.5 4932.6 4940.6 4953.9 5042.3 5050.5 5116.0 5118.6 5121.6 4804.9 4881.6 4887.9 4937.4 5120.4 3042.2 3056.4 3067.7 3067.8 3071.3 5929.7 5962.7 5970.7 5995.1 6009.1 5549.5 5810.7 5818.9 5821.5 5830.6 5940.8 6004.5 6029.5 6045.0 6049.7 5548.5 5777.2 5800.4 5808.8 5814.9 5682.3 5698.5 5726.8 5736.3 5741.2 5985.7 6006.5 6014.2 6023.9 6041.8 3904.5 3966.2 4041.1 4050.0 4051.4 5768.7 5774.6 5792.1 5796.2 5816.8 5536.3 5657.5 5669.4 5669.7 5688.9 5488.3 5546.6 5546.8 5552.7 5574.8 5427.8 5444.4 5447.2 5452.8 5458.7 5326.5 5585.5 5601.7 5639.7 5681.7 5556.8 5564.4 5572.2 5586.0 5609.4 20:21:07 INFO - PROCESS | 25541 | 20:21:07 INFO - PROCESS | 25541 | [#5] yui.html Cycles:180 Average:15366.35 Median:26331.16 stddev:18375.19 (69.8%) stddev-sans-first:18393.75 20:21:07 INFO - PROCESS | 25541 | Values: 704.6 737.3 771.8 776.8 828.7 13656.5 14030.0 14348.8 14409.1 14459.1 14472.6 14550.2 14551.3 14573.6 14582.6 673.6 690.8 691.7 795.9 810.5 693.3 782.9 809.1 816.7 817.9 853.3 854.0 854.5 855.3 856.0 696.6 848.5 848.8 850.0 850.1 602.7 615.6 616.3 621.6 622.0 13021.5 13107.0 13127.7 13133.9 13185.1 13440.3 13766.1 13766.4 13921.4 14109.6 12174.6 12507.7 12585.6 12596.7 12662.8 4465.1 4487.8 4531.5 4531.6 4675.8 58300.4 58589.7 58967.7 58979.1 59415.4 10302.4 10821.9 11177.3 11217.3 11231.7 20256.5 20311.3 20337.2 20341.2 20374.3 8342.8 8517.2 8675.3 8705.6 8957.9 4684.5 4707.7 4727.3 4794.3 4863.2 3374.7 3475.5 3476.2 3479.3 3493.3 614.6 623.4 628.2 638.2 641.3 645.2 666.9 687.3 745.6 770.6 9010.3 9300.9 9361.9 9372.4 9535.2 623.6 645.4 740.5 743.7 756.7 4245.4 4462.4 4508.2 4524.5 4582.4 61908.0 63352.4 65824.7 66374.0 66515.0 56947.7 57733.4 58468.4 58711.4 59892.4 53337.7 53426.0 53971.5 54869.7 55678.7 8197.9 8222.6 8465.2 8593.5 8878.4 36855.3 37282.3 37334.6 38087.8 38766.4 47868.0 49597.8 49966.3 49986.3 50222.2 10666.7 10827.7 10933.9 11120.9 11343.4 12352.1 12356.2 12461.4 12534.4 12543.9 11412.2 11591.8 11707.9 11767.8 12188.8 12148.8 12410.6 12436.2 12447.1 12854.5 11714.5 11747.8 11755.0 11965.9 12066.4 10457.5 10616.2 10669.1 10691.4 10763.7 9655.8 9778.0 9966.8 10066.9 10333.6 20:21:07 INFO - PROCESS | 25541 | -------- Summary: end -------- 20:21:07 INFO - PROCESS | 25541 | 20:21:08 INFO - TEST-INFO | 25541: exit 0 20:21:08 INFO - TEST-OK | dromaeo_css | took 1115135ms 20:21:08 INFO - TEST-START | kraken 20:21:08 INFO - operating with platform_type : linux_ 20:21:08 INFO - Initialising browser for kraken test... 20:21:08 INFO - TEST-INFO | started process 25722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasy9FW/profile http://localhost:45400/getInfo.html) 20:21:14 INFO - PROCESS | 25722 | __metrics Screen width/height:1600/1200 20:21:14 INFO - PROCESS | 25722 | colorDepth:24 20:21:14 INFO - PROCESS | 25722 | Browser inner width/height: 1024/697 20:21:14 INFO - PROCESS | 25722 | __metrics 20:21:15 ERROR - PROCESS | 25722 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:21:16 INFO - TEST-INFO | 25722: exit 0 20:21:16 INFO - Browser initialized. 20:21:16 INFO - Running cycle 1/1 for kraken test... 20:21:16 INFO - TEST-INFO | started process 25802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasy9FW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:28 INFO - PROCESS | 25802 | RSS: Main: 155762688 20:21:28 INFO - PROCESS | 25802 | 20:21:31 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:31 INFO - PROCESS | 25802 | RSS: Main: 214585344 20:21:31 INFO - PROCESS | 25802 | 20:21:34 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-dft) 20:21:35 INFO - PROCESS | 25802 | RSS: Main: 197550080 20:21:35 INFO - PROCESS | 25802 | 20:21:38 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-fft) 20:21:38 INFO - PROCESS | 25802 | RSS: Main: 268345344 20:21:38 INFO - PROCESS | 25802 | 20:21:41 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45400/tests/kraken/driver.html?testName=audio-oscillator) 20:21:41 INFO - PROCESS | 25802 | RSS: Main: 179306496 20:21:41 INFO - PROCESS | 25802 | 20:21:43 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:44 INFO - PROCESS | 25802 | RSS: Main: 182960128 20:21:44 INFO - PROCESS | 25802 | 20:21:47 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:47 INFO - PROCESS | 25802 | RSS: Main: 218390528 20:21:47 INFO - PROCESS | 25802 | 20:21:51 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45400/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:51 INFO - PROCESS | 25802 | RSS: Main: 220114944 20:21:51 INFO - PROCESS | 25802 | 20:21:54 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45400/tests/kraken/driver.html?testName=json-parse-financial) 20:21:55 INFO - PROCESS | 25802 | RSS: Main: 219918336 20:21:55 INFO - PROCESS | 25802 | 20:21:56 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:57 INFO - PROCESS | 25802 | RSS: Main: 207765504 20:21:57 INFO - PROCESS | 25802 | 20:21:59 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:59 INFO - PROCESS | 25802 | RSS: Main: 209973248 20:21:59 INFO - PROCESS | 25802 | 20:22:01 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:22:02 INFO - PROCESS | 25802 | RSS: Main: 215724032 20:22:02 INFO - PROCESS | 25802 | 20:22:05 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:22:05 INFO - PROCESS | 25802 | RSS: Main: 222859264 20:22:05 INFO - PROCESS | 25802 | 20:22:08 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:22:08 INFO - PROCESS | 25802 | RSS: Main: 219865088 20:22:08 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:45400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45400/tests/kraken/driver.html?testName=ai-astar) 20:22:10 INFO - PROCESS | 25802 | RSS: Main: 263102464 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | __start_tp_report 20:22:10 INFO - PROCESS | 25802 | _x_x_mozilla_page_load 20:22:10 INFO - PROCESS | 25802 | _x_x_mozilla_page_load_details 20:22:10 INFO - PROCESS | 25802 | |i|pagename|runs| 20:22:10 INFO - PROCESS | 25802 | |0;ai-astar;111;105;112;110;110;109;110;111;112;112 20:22:10 INFO - PROCESS | 25802 | |1;audio-beat-detection;152;125;126;175;124;137;156;131;178;130 20:22:10 INFO - PROCESS | 25802 | |2;audio-dft;160;159;160;161;159;161;161;160;161;160 20:22:10 INFO - PROCESS | 25802 | |3;audio-fft;73;74;76;140;83;75;73;74;107;75 20:22:10 INFO - PROCESS | 25802 | |4;audio-oscillator;84;83;106;82;82;83;112;82;82;126 20:22:10 INFO - PROCESS | 25802 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;116;117;117 20:22:10 INFO - PROCESS | 25802 | |6;imaging-darkroom;146;146;146;146;145;145;145;145;146;146 20:22:10 INFO - PROCESS | 25802 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;95;94 20:22:10 INFO - PROCESS | 25802 | |8;json-parse-financial;54;53;53;54;52;54;55;53;53;53 20:22:10 INFO - PROCESS | 25802 | |9;json-stringify-tinderbox;61;62;61;61;62;61;62;61;62;62 20:22:10 INFO - PROCESS | 25802 | |10;stanford-crypto-aes;79;79;78;79;80;86;82;80;108;80 20:22:10 INFO - PROCESS | 25802 | |11;stanford-crypto-ccm;132;125;118;137;129;119;118;131;125;121 20:22:10 INFO - PROCESS | 25802 | |12;stanford-crypto-pbkdf2;164;157;160;164;159;155;162;155;154;162 20:22:10 INFO - PROCESS | 25802 | |13;stanford-crypto-sha256-iterative;63;63;62;61;61;62;62;62;61;66 20:22:10 INFO - PROCESS | 25802 | __end_tp_report 20:22:10 INFO - PROCESS | 25802 | __start_cc_report 20:22:10 INFO - PROCESS | 25802 | _x_x_mozilla_cycle_collect,1619 20:22:10 INFO - PROCESS | 25802 | __end_cc_report 20:22:10 INFO - PROCESS | 25802 | __startTimestamp1464664930844__endTimestamp 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | ------- Summary: start ------- 20:22:10 INFO - PROCESS | 25802 | Number of tests: 14 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.10 (1.9%) stddev-sans-first:2.20 20:22:10 INFO - PROCESS | 25802 | Values: 111.0 105.0 112.0 110.0 110.0 109.0 110.0 111.0 112.0 112.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:144.50 stddev:20.60 (14.3%) stddev-sans-first:21.62 20:22:10 INFO - PROCESS | 25802 | Values: 152.0 125.0 126.0 175.0 124.0 137.0 156.0 131.0 178.0 130.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:22:10 INFO - PROCESS | 25802 | Values: 160.0 159.0 160.0 161.0 159.0 161.0 161.0 160.0 161.0 160.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.50 stddev:21.92 (29.4%) stddev-sans-first:22.81 20:22:10 INFO - PROCESS | 25802 | Values: 73.0 74.0 76.0 140.0 83.0 75.0 73.0 74.0 107.0 75.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.00 stddev:16.25 (19.8%) stddev-sans-first:16.97 20:22:10 INFO - PROCESS | 25802 | Values: 84.0 83.0 106.0 82.0 82.0 83.0 112.0 82.0 82.0 126.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:22:10 INFO - PROCESS | 25802 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:22:10 INFO - PROCESS | 25802 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:22:10 INFO - PROCESS | 25802 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.87 20:22:10 INFO - PROCESS | 25802 | Values: 54.0 53.0 53.0 54.0 52.0 54.0 55.0 53.0 53.0 53.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 20:22:10 INFO - PROCESS | 25802 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 61.0 62.0 62.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:80.00 stddev:9.04 (11.3%) stddev-sans-first:9.46 20:22:10 INFO - PROCESS | 25802 | Values: 79.0 79.0 78.0 79.0 80.0 86.0 82.0 80.0 108.0 80.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:127.00 stddev:6.60 (5.2%) stddev-sans-first:6.57 20:22:10 INFO - PROCESS | 25802 | Values: 132.0 125.0 118.0 137.0 129.0 119.0 118.0 131.0 125.0 121.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:161.00 stddev:3.79 (2.4%) stddev-sans-first:3.61 20:22:10 INFO - PROCESS | 25802 | Values: 164.0 157.0 160.0 164.0 159.0 155.0 162.0 155.0 154.0 162.0 20:22:10 INFO - PROCESS | 25802 | 20:22:10 INFO - PROCESS | 25802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.56 20:22:10 INFO - PROCESS | 25802 | Values: 63.0 63.0 62.0 61.0 61.0 62.0 62.0 62.0 61.0 66.0 20:22:10 INFO - PROCESS | 25802 | -------- Summary: end -------- 20:22:10 INFO - PROCESS | 25802 | 20:22:11 INFO - TEST-INFO | 25802: exit 0 20:22:11 INFO - TEST-OK | kraken | took 63069ms 20:22:11 INFO - SUITE-END | took 1178s 20:22:12 INFO - Completed test suite (00:19:38) 20:22:12 INFO - javascript benchmark 20:22:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.4561951658457, 3120.765942554309, 3122.203838021305, 3162.241062145083, 3179.4753865612174, 5183.559397451221, 5259.76331065102, 5294.497022782839, 5330.253764472972, 5354.437784032674, 5251.2385704072885, 5267.52592266696, 5274.551663108631, 5279.868003299919, 5323.707196104213, 4765.094632019923, 4829.4687584365865, 4851.805927762885, 4856.247281671346, 5008.724520151391, 4918.262260660894, 4979.676321039139, 4986.825461108862, 4991.850244492671, 5007.949920500785, 4662.323963025359, 4797.0, 4825.662203645747, 4853.369062021915, 4860.125177468054, 4828.758562071917, 4832.0, 4854.878628034292, 4866.635002374801, 4897.730624815634, 4828.420589529243, 4830.082284365959, 4847.757612119415, 4861.927071093936, 4874.098291816025, 5087.516685914869, 5162.432132465426, 5205.037068142406, 5312.814051508179, 5319.20211968204, 5745.827625171251, 5754.942450575482, 5758.971205143989, 5760.164776107483, 5768.019436695772, 5491.2312276281355, 5750.05124154514, 5796.478316951452, 5801.970990145022, 5810.1865738796605, 5278.9208161877605, 5337.786488540453, 5342.706151161685, 5399.7030163341, 5405.648632838853, 5849.912251316234, 5861.912071318934, 5872.442117998783, 5881.911771323434, 5895.67573783446, 5411.377691565442, 5494.725263736797, 5651.80218692352, 5656.830295091154, 5663.235463212496, 5613.382527921925, 5664.26364572603, 5677.318721753333, 5678.886422271531, 5680.517156041783, 5601.327840659147, 5633.492985631313, 5644.3508996465935, 5648.576356773258, 5655.575831812548, 5432.91850622241, 5574.498295153456, 5606.0, 5651.434856514398, 5667.659940403589, 4328.091100868853, 4337.522872484024, 4339.045410009793, 4374.934375984363, 4375.518692943773, 3851.2490064437725, 3861.8069096545623, 3885.2812229737024, 3912.882613521599, 3916.2754890345377, 5236.92144617831, 5238.161894097002, 5380.381256155514, 5384.030874442559, 5428.809991650273, 5720.685362305113, 5748.425157484218, 5753.597248192586, 5773.566982476331, 5804.2744656917885, 5478.780848766084, 5487.42382049887, 5490.066688662937, 5493.505584497414, 5496.285482887279, 4844.563989240985, 4936.975315123474, 4940.901181976412, 4977.427595826454, 5028.472010438924, 6001.5798894077, 6005.549583781234, 6018.8194354169445, 6024.909626355608, 6049.213602231682, 5760.884782304414, 5761.740721667619, 5763.193152958505, 5765.4811067004175, 5770.682612456355, 5749.683767392834, 5916.171735957056, 5919.378465261086, 5995.430434108753, 6006.639601623917, 5617.213590097308, 5634.830955071355, 5651.915221271602, 5655.123455864347, 5673.8297851064535, 5742.483176514133, 5756.309242890712, 5760.510356619734, 5763.308402991668, 5772.422757724194, 5375.704336261543, 5538.806141785019, 5568.721563921868, 5590.720463976703, 5600.775968961196, 5586.1062230043, 5595.888082238251, 5596.692181930033, 5600.0479918414785, 5601.6358936668985, 5482.671039737628, 5496.917546236889, 5502.504774570308, 5503.7798488060025, 5548.167774833807, 5420.186971954238, 5529.889402212014, 5586.1062230043, 5598.3282006159525, 5685.630434021776, 5465.316835395575, 5502.862428439321, 5503.972480137573, 5506.531944784738, 5549.500544950974], "value": 5263.442996000143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.4259824465881, 613.7330261336319, 641.4163111568473, 645.799802061361, 656.6060363781728, 31778.0, 32339.51490727638, 43530.99999999996, 44089.11821763563, 44213.0, 45491.54508454914, 45736.08527829441, 46033.53966460334, 46058.0, 46080.76959615206, 8520.06279309277, 8682.30541556674, 8732.476051436903, 8740.257078148334, 8748.431351962134, 8747.169018943223, 8863.556822158866, 8877.112288771135, 8879.200871921526, 8893.333000025024, 8933.910660893373, 8965.596548155349, 8967.506787126706, 8995.775105622379, 9004.279657627374, 8889.066648001964, 8892.644294228223, 8901.955490222572, 8906.198442140238, 8948.284137269035, 8769.649214031431, 8862.202401783807, 8862.689805856828, 8867.778305542348, 8867.955660221722, 40613.39079913804, 40870.38694419556, 41064.79467602643, 41092.178156437, 41315.0, 3232.6282477514915, 3251.5772949516413, 3353.7024259241707, 3472.808995505246, 3628.7097032237357, 32008.679913201035, 32528.674713253036, 33052.33895322104, 33917.83041084779, 34044.14889627754, 4221.02916329246, 4285.1429714057, 4307.0, 4336.457942757155, 4355.237833379146, 326866.0, 327555.9999999976, 327619.0, 327981.0, 328833.0, 58868.41131588715, 58973.70513147407, 59239.70380148072, 59330.703346482995, 59420.40579594235, 59614.403855961755, 60422.0, 61638.38361616416, 62386.68806656029, 62548.0, 15797.447089351817, 16148.0, 16161.919190404207, 16163.191840407933, 16213.756793648105, 12824.140499627501, 12845.678858028625, 12924.870751292367, 12931.870681293067, 12942.158759680591, 16097.585362195765, 17104.572385690208, 17326.913365433345, 17418.39035633772, 17716.20277087534, 6001.879962400815, 6019.138182471986, 6027.45752882234, 6085.6348619083, 6098.237720284965, 945.2201933404968, 1026.743314171457, 1059.2161800267747, 1117.983230251547, 1156.9305841649527, 32231.838840805645, 32826.83586582052, 33208.833955830065, 33210.83394583012, 33781.324373512885, 1130.2879186112696, 1148.4315263944234, 1150.7813515432208, 1168.9707757306135, 1180.1738782851867, 17054.14729263532, 17353.65292694139, 17421.738673919903, 17435.47693569195, 17492.5626859327, 517131.0, 523258.0, 524749.0, 525329.0, 525929.0, 56081.158782618295, 57002.714986425635, 57112.42887571071, 57312.713436432554, 57351.13973290404, 1234.4383305595932, 1320.7160460500845, 1359.2795818216362, 1366.3168415792104, 1393.9721205576034, 31171.532427014066, 33499.49750753692, 33539.329213415105, 33609.99170024903, 33966.83016585, 44216.55783442253, 44646.3303050461, 44672.10655786931, 44704.32943505785, 44709.329360058975, 393666.0, 400898.0, 401296.0, 402233.0, 402332.0, 35291.470627940085, 40325.0, 41114.588854111076, 42295.15409691851, 44627.0, 47249.52750472589, 47312.0, 47796.761016194694, 48130.51869481261, 48349.0, 39512.0, 40773.38839917344, 41504.377434337905, 41530.37704434375, 43412.78293608512, 41164.794176028925, 41485.1702965945, 42307.7884610575, 42378.36432453454, 42499.5750042508, 42041.57958420377, 42310.57689423066, 42812.571874282105, 42975.57024429716, 43088.569114308455, 35450.0, 36962.26075478529, 37331.81334093312, 37429.0, 37605.81197093997, 28285.43429131447, 28380.85809570939, 28434.57348139821, 28521.42957140887, 28695.0], "value": 20076.10394765614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3532027892444, 381.5650158818945, 396.80754833905553, 402.5531659857556, 413.10562631901934, 18418.355357562486, 19092.33176838811, 19880.602387952233, 19881.50296242593, 19881.701774473375, 16890.83109168908, 17362.739558906625, 17606.735898961495, 17767.733483997752, 17795.110244487787, 3994.400839874013, 5204.739763011844, 5579.13523403873, 5597.832065038035, 5604.915926261109, 5018.623603229754, 6229.314775374705, 6234.563580549363, 6236.968815155918, 6237.781677641284, 5417.133258678612, 6069.1806606108275, 6251.624902505864, 6260.342664020281, 6263.185785847856, 3834.9041273968232, 5605.831825045255, 5792.449717276873, 6856.485763567753, 7257.274272572753, 6857.862842743117, 7050.647467626598, 7133.500654954155, 7173.533720308215, 7174.246704096047, 25176.118835840658, 25782.226533204033, 26166.6075008875, 26173.607395889077, 26178.345541361618, 2448.375664205634, 2571.4085760275243, 2634.5916382960672, 2833.3058400691757, 3334.549835772164, 14546.70906581873, 15547.766783498257, 15579.0, 15912.363505459767, 16185.595360115973, 2015.5968806238811, 2048.3240530624857, 2097.2345094040716, 2159.6436587962967, 2240.0703707961175, 87723.56138219268, 89050.55474722585, 91318.0, 92007.0, 93545.53227233888, 17089.48731538056, 17478.30086796514, 17480.0, 17611.0, 17750.46748597544, 31371.3922898865, 31423.84288078545, 31851.681483185333, 31871.88448404295, 31979.200519987186, 9213.309001824757, 9644.373115747454, 9648.276379271583, 9658.179054780423, 9736.902630973742, 7927.207279272026, 8051.074126475531, 8144.918550814416, 8154.3884208684585, 8156.143604921516, 8772.868406973901, 8878.556072196365, 8906.064863189402, 8926.464412135163, 9171.40385874916, 3232.095013396253, 3260.250142467246, 3397.6092749333648, 3439.9828000859834, 3616.5298511193378, 862.5730263519598, 997.8602995580625, 1005.7485628592851, 1072.51736718477, 1139.549877798265, 18051.909740451214, 18554.536136596693, 20348.18607255723, 20434.182632694527, 20489.795102049087, 1032.2516175772655, 1085.9565617375374, 1087.456271864068, 1088.9128869690405, 1091.0780390569955, 10334.896651033543, 10432.530536125741, 10753.301035432829, 11202.831957520644, 11447.198696091195, 195499.0, 195518.0, 195581.0, 196327.0, 196647.0, 90019.0, 95562.52218739002, 96485.51757241169, 96754.03245967592, 97331.0, 1049.223574554824, 1082.2802836113897, 1082.5290998415715, 1091.792559413709, 1101.5208384352832, 17303.826961730727, 17344.219510121824, 17551.122443878012, 17564.91217543904, 17745.91127044408, 37138.25723485569, 37158.6284137166, 40353.25951294524, 40514.59485405226, 41035.794821026895, 52901.735491322295, 53642.73178634238, 53918.19122713241, 54569.181462278895, 56334.7183264081, 8501.702440414556, 8532.786680332792, 8600.268977137013, 8621.827563448822, 8638.0, 8034.116247212685, 9619.855702164334, 12053.75892482163, 13558.661033474242, 13584.796228056784, 11289.266197697123, 11745.588904388305, 11824.113191510844, 11895.583654572049, 12199.390030498262, 5682.886342273214, 10728.356298622108, 11637.0, 11688.123390745897, 11919.0, 6552.737890484518, 10635.734106647396, 11017.0, 11813.350265735467, 12063.638090857288, 8632.266257367943, 8674.913250867663, 8750.868736968823, 8970.86543701832, 8993.28053755711, 11028.779424411627, 11797.705057373634, 11903.583374581847, 12212.389380531116, 12328.321942292901], "value": 9885.05855985808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.8922486201093, 1514.2504460292157, 1531.961700957476, 1697.74533819927, 1816.5095424235449, 8066.71766488173, 8375.455595386304, 8385.87421188682, 8627.180417860309, 8637.870431943526, 8339.291160251385, 8557.91442085579, 8562.357823163256, 8562.957185214082, 8563.65745370186, 2014.9798502015012, 2083.874967501947, 2085.624587574236, 2335.7781010803947, 2366.503034362786, 2317.2353123469297, 2417.226487523993, 2419.8427102238297, 2429.4047958250167, 2431.598786200275, 2284.326123793485, 2304.8156147508157, 2310.4108452344713, 2319.1766922742354, 2327.6159433693506, 1963.9018049097488, 2233.452804063015, 2292.793648571628, 2327.2320134355623, 2328.0571368595747, 2327.3483424641126, 2366.183666635008, 2366.8816559171973, 2368.1948137633117, 2369.644553316999, 8459.95770021152, 8512.70205542803, 8515.403921725481, 8521.659133634646, 8522.48865068098, 4839.879003024953, 4959.082569724576, 4973.079980203674, 4975.0, 4975.552200301954, 3101.6743241959493, 3267.591551056118, 3408.216110294621, 3413.812240326781, 3420.0936751760805, 1136.7101389145798, 1138.3170097941252, 1146.72478605135, 1161.9593314234046, 1166.7958107331183, 11747.94126029373, 11765.705857353549, 11773.352465614387, 11773.411329433495, 11791.528338866521, 4488.887777805581, 4515.435570553681, 4591.701539399928, 4591.9438529137815, 4663.953360466352, 10011.79976400468, 10017.298789084694, 10019.599216031276, 10022.298439109192, 10030.598776049022, 5041.092603331435, 5106.514881086291, 5107.259447380109, 5111.156659151273, 5112.974435127875, 3899.415087736862, 4467.5755803198645, 4648.372469716613, 4707.62339012885, 4711.505291944365, 3918.45141680165, 3960.7227494075714, 4057.634812866856, 4106.137711080647, 4110.486189226347, 1283.0505425984704, 1288.0854593238719, 1293.8188653588504, 1301.537954026307, 1312.553731731216, 883.9779005524784, 915.9969833032818, 952.1002652493328, 983.6753871222622, 986.9636881274633, 5594.0769772987815, 5594.832155035356, 5772.134179873053, 5788.652680839163, 5866.941330586725, 459.48996613758703, 470.37440204527894, 479.2380115616187, 486.56938609330996, 487.1085912779605, 4162.7502349859105, 4175.185838761412, 4182.665386769051, 4201.537830838605, 4230.661547076226, 9986.900130998598, 10334.793304133875, 10423.530941107669, 10437.739056523496, 10440.321379110334, 10256.230782691327, 10318.329308594917, 10327.277090603737, 10337.276390652582, 10337.9483102584, 7519.0, 7721.343685786771, 7806.68773249075, 7819.5699236541395, 7831.725889593837, 5954.523638108854, 5958.6424814511265, 5961.105834124916, 6128.479079278133, 6214.471769899609, 9427.15155635996, 9806.950965245129, 9814.312998090065, 9818.509074546388, 9820.214382849497, 9482.620695172116, 9634.662786802428, 9769.951150244204, 9830.803383932423, 9839.754006149904, 6885.586864788129, 7304.890426643711, 7465.141508726349, 7593.772186834404, 7766.728164514215, 8152.184781521801, 8168.591570421337, 8192.467489613156, 8230.876536852073, 8240.876386854083, 6955.23492415844, 7036.929630703832, 7091.042709234393, 7196.316349946746, 7272.709091636275, 7226.7109315626785, 7231.8553628928175, 7248.238934911758, 7358.374538164316, 7406.888896666446, 6675.4325882300545, 6739.0, 6746.595204287759, 6750.1562304711915, 6751.122354093936, 4950.133726597759, 5087.465816089258, 5136.332276803992, 5154.5103215194495, 5167.92248116271, 5064.265681476239, 5223.9477605223465, 5224.947750522446, 5249.527542521191, 5285.7621407036], "value": 4447.131559428262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.4376122978638, 320.2649918437187, 330.4893938864455, 331.14894720568134, 332.1811734075503, 5130.769115389807, 5250.684958902469, 5259.289995850559, 5340.946590534093, 5364.007658583165, 5243.659162154467, 5258.55302299305, 5272.657277276974, 5279.472052794718, 5306.310179676646, 4147.755673297998, 4148.377743338493, 4154.667626589866, 4156.792160391976, 4199.517055538621, 3893.9415908761393, 3943.487346644932, 4148.522919864209, 4174.519930208019, 4177.1829254274335, 4138.172365526892, 4139.544650088488, 4139.917201655965, 4143.694736158101, 4157.750534967897, 4144.399062135988, 4149.751014939098, 4152.27335216339, 4156.958430415687, 4188.832446702128, 3471.6354782747953, 3702.778083232527, 3722.7952462614544, 3723.5345581802276, 3724.2179142380132, 5092.3125378073855, 5145.228215767665, 5164.741762911839, 5166.121759300928, 5176.5858731301405, 4700.929486057712, 4721.0, 4730.172219861511, 4732.337472753818, 4756.952430475721, 5439.782408703647, 5535.778568857241, 5602.523785478239, 5608.4111168327145, 5622.718864056781, 3940.271049855786, 3949.2891279569667, 3971.0415740273393, 3973.2450834341385, 3986.3223252046932, 5828.679422631796, 5871.911921321183, 5881.529477641821, 5882.3529411764675, 5924.792632257893, 3831.0, 3953.031507280735, 3961.8415263389143, 3963.147923196527, 3979.0, 3950.7036972226624, 3980.24375368679, 3982.2433737590345, 3989.0625702959783, 4010.1578668479947, 4596.195665758479, 4627.305904114342, 4632.5135860734135, 4678.345031695565, 4689.249720044844, 5536.944630553723, 5539.723013849291, 5673.092305231144, 5676.148577713376, 5725.8568535786935, 1360.6394305509048, 1410.3371415434729, 1421.5664222412263, 1423.8932080094035, 1430.8497607751244, 895.9417637853519, 896.1173244354305, 912.1334732004622, 918.4030380252756, 918.807050519385, 4690.170833374987, 4843.529799802126, 4932.55606995365, 4940.555350018443, 4953.885375790491, 5042.268871013755, 5050.520200580939, 5115.951229997841, 5118.564921981599, 5121.564667003272, 4804.903901921942, 4881.560659540658, 4887.902241955141, 4937.35814344133, 5120.359955005624, 3042.2242328206607, 3056.3734434440885, 3067.662557118715, 3067.8159310441447, 3071.293602471444, 5929.703514824328, 5962.701864906738, 5970.671613061237, 5995.092380195601, 6009.128676341906, 5549.472800083986, 5810.680412577264, 5818.883622327529, 5821.544613846539, 5830.591858569859, 5940.752441987144, 6004.519638428916, 6029.457348838538, 6044.969775151096, 6049.729556793035, 5548.472895075123, 5777.22007528995, 5800.4489573490455, 5808.82573522795, 5814.854628634318, 5682.346530149086, 5698.515626171822, 5726.795183854163, 5736.311642602915, 5741.224934633938, 5985.700714964321, 6006.489448396936, 6014.218151640259, 6023.939760602338, 6041.78853740117, 3904.472896158982, 3966.2464131814863, 4041.131156801302, 4049.9595004049584, 4051.372037334218, 5768.6538807669995, 5774.624649397776, 5792.131180322816, 5796.188533605215, 5816.796412125555, 5536.307961504812, 5657.519110875622, 5669.376368599534, 5669.716514174357, 5688.914666279927, 5488.313960754906, 5546.611737178358, 5546.833594992157, 5552.69460179694, 5574.832755017356, 5427.778749781425, 5444.352283969671, 5447.237386765777, 5452.754626041917, 5458.699771512446, 5326.493983071602, 5585.497305242548, 5601.719914004202, 5639.661620302795, 5681.659100453986, 5556.805286863344, 5564.38791732901, 5572.164175373727, 5585.96659617972, 5609.429359779268], "value": 4211.45310539215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.6018999265416, 737.3437640499956, 771.7954741993371, 776.7786180938434, 828.697525403228, 13656.52202172924, 14030.0, 14348.784768228485, 14409.135451872895, 14459.13245205287, 14472.5658230253, 14550.19973901435, 14551.27243637819, 14573.635659108528, 14582.562523124298, 673.599208470959, 690.8238399208195, 691.6749127909874, 795.936325093994, 810.4853418079532, 693.3101563943883, 782.85517179322, 809.1261437647356, 816.7263966571206, 817.8854960305562, 853.2875049333783, 853.9914600853974, 854.5171977832505, 855.2730179347536, 855.9899318803809, 696.6377483708443, 848.4781859156606, 848.8005318750089, 849.9532525711084, 850.0649285785618, 602.6504627316147, 615.6275453350748, 616.300498933709, 621.5711159300068, 621.9751209951596, 13021.479140834355, 13107.0, 13127.671808204776, 13133.86866131336, 13185.142965707199, 13440.260785656785, 13766.105203161762, 13766.449342026306, 13921.443142274296, 14109.576712698636, 12174.5738899139, 12507.687307817287, 12585.622431327074, 12596.691687378821, 12662.81005784914, 4465.10697860426, 4487.775611219426, 4531.478879928784, 4531.614812740921, 4675.7895894684825, 58300.416995829924, 58589.707051464895, 58967.70516147435, 58979.11531327033, 59415.40584594142, 10302.433366164933, 10821.891781082088, 11177.329360238411, 11217.270877393106, 11231.719207019727, 20256.49358766013, 20311.28910488126, 20337.186512539334, 20341.186352545734, 20374.28689995843, 8342.833143337099, 8517.23344898962, 8675.349348798865, 8705.564721763887, 8957.865632015524, 4684.547046364271, 4707.741074240949, 4727.2909063640045, 4794.328793968847, 4863.2461968394955, 3374.6794054564775, 3475.5134281200653, 3476.165720227127, 3479.2693534357563, 3493.3013397320638, 614.6281499692711, 623.3766233766233, 628.1739512541085, 638.1894993358409, 641.3169973977699, 645.2321737132891, 666.9199696036507, 687.2920891481682, 745.5899255409503, 770.5936665585217, 9010.27917766577, 9300.863630240588, 9361.906380936103, 9372.437653740797, 9535.189508891683, 623.5884316351187, 645.4094503529312, 740.5408646639011, 743.7396911081079, 756.6519401075567, 4245.405643209953, 4462.397576327219, 4508.233600287959, 4524.524924882906, 4582.373257493542, 61908.0, 63352.36647633557, 65824.67087664627, 66374.0, 66515.0, 56947.71526142343, 57733.42266577281, 58468.415315847145, 58711.412885870595, 59892.401075989554, 53337.73331133397, 53426.0, 53971.46028539664, 54869.72565137229, 55678.72160639171, 8197.877031844408, 8222.588870556328, 8465.238128568459, 8593.52735599548, 8878.378513503993, 36855.26289474249, 37282.25435491329, 37334.62665373312, 38087.80956095202, 38766.4185037219, 47868.0, 49597.75201123971, 49966.25050624171, 49986.25020624766, 50222.246666300765, 10666.73333166677, 10827.729306767395, 10933.890661093288, 11120.867128010645, 11343.432828358715, 12352.135350525377, 12356.21465976399, 12461.439235234255, 12534.373281335715, 12543.93728031354, 11412.201145920038, 11591.826122608, 11707.88292117102, 11767.823482647596, 12188.817167742669, 12148.817767733315, 12410.5656302029, 12436.19164754288, 12447.128700991207, 12854.485820567073, 11714.531418743496, 11747.823782643438, 11755.0, 11965.940170299093, 12066.396680166132, 10457.529411176667, 10616.1507079435, 10669.146468282364, 10691.411972341595, 10763.67708968701, 9655.758606034906, 9778.0, 9966.750831229278, 10066.949665251626, 10333.638322658671], "value": 6768.635845557862, "unit": "score"}], "name": "dromaeo_css", "value": 7139.453259646795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 110.0, 110.0, 109.0, 110.0, 111.0, 112.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 175.0, 124.0, 137.0, 156.0, 131.0, 178.0, 130.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 140.0, 83.0, 75.0, 73.0, 74.0, 107.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 106.0, 82.0, 82.0, 83.0, 112.0, 82.0, 82.0, 126.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 52.0, 54.0, 55.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 80.0, 86.0, 82.0, 80.0, 108.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 118.0, 137.0, 129.0, 119.0, 118.0, 131.0, 125.0, 121.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 157.0, 160.0, 164.0, 159.0, 155.0, 162.0, 155.0, 154.0, 162.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 66.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1492.8, "alertThreshold": 2.0}]} 20:22:12 INFO - Return code: 0 20:22:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:22:12 ERROR - # TBPL SUCCESS # 20:22:12 INFO - Running post-action listener: _resource_record_post_action 20:22:12 INFO - ##### 20:22:12 INFO - ##### Finished run-tests step (success) 20:22:12 INFO - ##### 20:22:12 INFO - Running post-run listener: _resource_record_post_run 20:22:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538185728; Read time: 464; Write time: 1825632 20:22:12 INFO - TinderboxPrint: CPU usage
13.3% 20:22:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 464 20:22:12 INFO - TinderboxPrint: I/O write bytes / time
538,185,728 / 1,825,632 20:22:12 INFO - TinderboxPrint: CPU idle
8,292.4 (86.6%) 20:22:12 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 20:22:12 INFO - TinderboxPrint: Swap in / out
0 / 0 20:22:12 INFO - install - Wall time: 20s; CPU: 17.0%; Read bytes: 0; Write bytes: 225271808; Read time: 0; Write time: 886948 20:22:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290537472; Read time: 464; Write time: 934648 20:22:12 INFO - Running post-run listener: _upload_blobber_files 20:22:12 INFO - Blob upload gear active. 20:22:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:22:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:22:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:13 INFO - (blobuploader) - INFO - Done attempting. 20:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:22:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:17 INFO - (blobuploader) - INFO - Done attempting. 20:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:18 INFO - (blobuploader) - INFO - Done attempting. 20:22:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:18 INFO - Return code: 0 20:22:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:22:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95916f4214caeb61263cf847fb1615acf72dc4b1caf644fe08973c87ebfa717a0cd9c1b8f68264d5a8b2905f0af8ae726dbda499c79c0e6a6ad8d5118ad6b816", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cd86f1a6d774a1ffa8febe0a52a040fb932d82b48c4021cc47a84a95e71a98cb7f75b2b0ef441df59987a202320375b0f14a037dad2cb66d803c4455ec4d0b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d848e24269b00c2b5f6308be05d1262974b095ba2d29a073b2957a3a195c639addff46f4ef6e2ac7f94dc6da2cc28c4d3719d71308496ab1e9cf04f5de9e3cea"} 20:22:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:22:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:22:18 INFO - Contents: 20:22:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95916f4214caeb61263cf847fb1615acf72dc4b1caf644fe08973c87ebfa717a0cd9c1b8f68264d5a8b2905f0af8ae726dbda499c79c0e6a6ad8d5118ad6b816", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cd86f1a6d774a1ffa8febe0a52a040fb932d82b48c4021cc47a84a95e71a98cb7f75b2b0ef441df59987a202320375b0f14a037dad2cb66d803c4455ec4d0b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d848e24269b00c2b5f6308be05d1262974b095ba2d29a073b2957a3a195c639addff46f4ef6e2ac7f94dc6da2cc28c4d3719d71308496ab1e9cf04f5de9e3cea"} 20:22:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:18 INFO - Copying logs to upload dir... 20:22:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:22:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.286637 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-30 20:22:18.064707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 20:22:18.067921) ========= 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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 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/95916f4214caeb61263cf847fb1615acf72dc4b1caf644fe08973c87ebfa717a0cd9c1b8f68264d5a8b2905f0af8ae726dbda499c79c0e6a6ad8d5118ad6b816", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cd86f1a6d774a1ffa8febe0a52a040fb932d82b48c4021cc47a84a95e71a98cb7f75b2b0ef441df59987a202320375b0f14a037dad2cb66d803c4455ec4d0b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d848e24269b00c2b5f6308be05d1262974b095ba2d29a073b2957a3a195c639addff46f4ef6e2ac7f94dc6da2cc28c4d3719d71308496ab1e9cf04f5de9e3cea"} build_url:https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/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/95916f4214caeb61263cf847fb1615acf72dc4b1caf644fe08973c87ebfa717a0cd9c1b8f68264d5a8b2905f0af8ae726dbda499c79c0e6a6ad8d5118ad6b816", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cd86f1a6d774a1ffa8febe0a52a040fb932d82b48c4021cc47a84a95e71a98cb7f75b2b0ef441df59987a202320375b0f14a037dad2cb66d803c4455ec4d0b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d848e24269b00c2b5f6308be05d1262974b095ba2d29a073b2957a3a195c639addff46f4ef6e2ac7f94dc6da2cc28c4d3719d71308496ab1e9cf04f5de9e3cea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 20:22:18.097317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:22:18.098092) ========= 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=8783db0840cc980e80bb0bd400000236-1464663026.418760-1581587791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:22:18.182115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 20:22:18.182815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 20:22:18.183468) ========= ========= Total master_lag: 0.18 =========