builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1464692989.03 results: success (0) buildid: 20160531025850 builduid: 0d5945afc0714e94abf9ebc5f63ad40c revision: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.033504) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.033981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.034280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.053517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.053822) ========= 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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 04:09:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-31 04:09:51 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.182021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.182371) ========= 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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:49.233343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 04:09:49.233719) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dc4d7f68030e9edd22ad0bb0bd2244d047dd767d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dc4d7f68030e9edd22ad0bb0bd2244d047dd767d --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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 04:09:51,288 truncating revision to first 12 chars 2016-05-31 04:09:51,288 Setting DEBUG logging. 2016-05-31 04:09:51,288 attempt 1/10 2016-05-31 04:09:51,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc4d7f68030e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 04:09:52,642 unpacking tar archive at: mozilla-central-dc4d7f68030e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.703478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 04:09:50.951564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:50.951887) ========= script_repo_revision: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:50.952295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:50.952563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 04:09:50.963384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-31 04:09:50.963719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:53 INFO - MultiFileLogger online at 20160531 04:09:53 in /builds/slave/test 04:09:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:09:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:53 INFO - {'append_to_log': False, 04:09:53 INFO - 'base_work_dir': '/builds/slave/test', 04:09:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:09:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:53 INFO - 'branch': 'Firefox-Non-PGO', 04:09:53 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:53 INFO - 'config_files': ('talos/linux_config.py',), 04:09:53 INFO - 'default_actions': ('clobber', 04:09:53 INFO - 'read-buildbot-config', 04:09:53 INFO - 'download-and-extract', 04:09:53 INFO - 'populate-webroot', 04:09:53 INFO - 'create-virtualenv', 04:09:53 INFO - 'install', 04:09:53 INFO - 'run-tests'), 04:09:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:53 INFO - 'download_minidump_stackwalk': True, 04:09:53 INFO - 'download_symbols': 'ondemand', 04:09:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:53 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:53 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:53 INFO - 'installer_path': 'installer.exe', 04:09:53 INFO - 'log_level': 'info', 04:09:53 INFO - 'log_name': 'talos', 04:09:53 INFO - 'log_to_console': True, 04:09:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:53 INFO - 'opt_config_files': (), 04:09:53 INFO - 'pip_index': False, 04:09:53 INFO - 'sps_profile': False, 04:09:53 INFO - 'sps_profile_interval': 0, 04:09:53 INFO - 'suite': 'dromaeojs', 04:09:53 INFO - 'system_bits': '32', 04:09:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:53 INFO - 'title': 'talos-linux64-ix-065', 04:09:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:53 INFO - 'use_talos_json': True, 04:09:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:53 INFO - 'work_dir': 'build'} 04:09:53 INFO - ##### 04:09:53 INFO - ##### Running clobber step. 04:09:53 INFO - ##### 04:09:53 INFO - Running pre-action listener: _resource_record_pre_action 04:09:53 INFO - Running main action method: clobber 04:09:53 INFO - rmtree: /builds/slave/test/build 04:09:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:53 INFO - Running post-action listener: _resource_record_post_action 04:09:53 INFO - ##### 04:09:53 INFO - ##### Finished clobber step (success) 04:09:53 INFO - ##### 04:09:53 INFO - ##### 04:09:53 INFO - ##### Running read-buildbot-config step. 04:09:53 INFO - ##### 04:09:53 INFO - Running pre-action listener: _resource_record_pre_action 04:09:53 INFO - Running main action method: read_buildbot_config 04:09:53 INFO - Using buildbot properties: 04:09:53 INFO - { 04:09:53 INFO - "project": "", 04:09:53 INFO - "product": "firefox", 04:09:53 INFO - "script_repo_revision": "production", 04:09:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:09:53 INFO - "repository": "", 04:09:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:09:53 INFO - "buildid": "20160531025850", 04:09:53 INFO - "pgo_build": "False", 04:09:53 INFO - "basedir": "/builds/slave/test", 04:09:53 INFO - "buildnumber": 600, 04:09:53 INFO - "slavename": "talos-linux64-ix-065", 04:09:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:09:53 INFO - "platform": "ubuntu64_hw", 04:09:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:09:53 INFO - "branch": "mozilla-central", 04:09:53 INFO - "repo_path": "mozilla-central", 04:09:53 INFO - "revision": "dc4d7f68030e9edd22ad0bb0bd2244d047dd767d", 04:09:53 INFO - "stage_platform": "linux64", 04:09:53 INFO - "builduid": "0d5945afc0714e94abf9ebc5f63ad40c", 04:09:53 INFO - "slavebuilddir": "test" 04:09:53 INFO - } 04:09:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:09:53 INFO - Running post-action listener: _resource_record_post_action 04:09:53 INFO - ##### 04:09:53 INFO - ##### Finished read-buildbot-config step (success) 04:09:53 INFO - ##### 04:09:53 INFO - ##### 04:09:53 INFO - ##### Running download-and-extract step. 04:09:53 INFO - ##### 04:09:53 INFO - Running pre-action listener: _resource_record_pre_action 04:09:53 INFO - Running main action method: download_and_extract 04:09:53 INFO - mkdir: /builds/slave/test/build/tests 04:09: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')]} 04:09:53 INFO - https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:09:54 INFO - Downloaded 1361 bytes. 04:09:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:09:54 INFO - Using the following test package requirements: 04:09:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'jsshell-linux-x86_64.zip'], 04:09:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:54 INFO - https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:00 INFO - Downloaded 22837958 bytes. 04:10:00 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'] 04:10:00 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 04:10:01 INFO - Return code: 0 04:10:01 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 04:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:01 INFO - https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:07 INFO - Downloaded 22837958 bytes. 04:10:07 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'] 04:10:07 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 04:10:08 INFO - Return code: 0 04:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:08 INFO - https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:09 INFO - Downloaded 10834055 bytes. 04:10:09 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'] 04:10:09 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 04:10:09 INFO - Return code: 0 04:10: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')]} 04:10:09 INFO - https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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 04:10:10 INFO - Downloaded 54993225 bytes. 04:10:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:10 INFO - mkdir: /builds/slave/test/properties 04:10:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:10 INFO - Contents: 04:10:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:11 INFO - Running post-action listener: _resource_record_post_action 04:10:11 INFO - Running post-action listener: set_extra_try_arguments 04:10:11 INFO - ##### 04:10:11 INFO - ##### Finished download-and-extract step (success) 04:10:11 INFO - ##### 04:10:11 INFO - ##### 04:10:11 INFO - ##### Running populate-webroot step. 04:10:11 INFO - ##### 04:10:11 INFO - Running pre-action listener: _resource_record_pre_action 04:10:11 INFO - Running main action method: populate_webroot 04:10:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:11 INFO - '--tppagecycles', 04:10:11 INFO - '7'], 04:10:11 INFO - 'tests': ['tsvgm']}}, 04:10:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['damp', 'tps']}, 04:10:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'tests': ['damp', 'tps']}, 04:10:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['dromaeo_dom']}, 04:10:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tsvgx', 04:10:11 INFO - 'tsvgr_opacity', 04:10:11 INFO - 'tart', 04:10:11 INFO - 'tscrollx', 04:10:11 INFO - 'cart']}, 04:10:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:11 INFO - 'tsvgr_opacity', 04:10:11 INFO - 'tart', 04:10:11 INFO - 'tscrollx', 04:10:11 INFO - 'cart']}, 04:10:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tp5o']}, 04:10:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'tests': ['tp5o']}, 04:10:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s', 04:10:11 INFO - '--xperf_path', 04:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:11 INFO - 'tests': ['tp5n']}, 04:10:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:11 INFO - 'talos_options': ['--xperf_path', 04:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:11 INFO - 'tests': ['tp5n']}}, 04:10:11 INFO - 'talos.zip': {'path': '', 04:10:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:11 INFO - Running post-action listener: _resource_record_post_action 04:10:11 INFO - ##### 04:10:11 INFO - ##### Finished populate-webroot step (success) 04:10:11 INFO - ##### 04:10:11 INFO - ##### 04:10:11 INFO - ##### Running create-virtualenv step. 04:10:11 INFO - ##### 04:10:11 INFO - Running pre-action listener: _resource_record_pre_action 04:10:11 INFO - Running main action method: create_virtualenv 04:10:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:11 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 04:10:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:11 INFO - Using real prefix '/usr' 04:10:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:14 INFO - Installing pip.................done. 04:10:14 INFO - Return code: 0 04:10:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:14 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:14 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 04:10:14 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 04:10:14 INFO - Using env: {'DISPLAY': ':0', 04:10:14 INFO - 'HOME': '/home/cltbld', 04:10:14 INFO - 'LANG': 'en_US.UTF-8', 04:10:14 INFO - 'LANGUAGE': 'en_US:en', 04:10:14 INFO - 'LOGNAME': 'cltbld', 04:10:14 INFO - 'MAIL': '/var/mail/cltbld', 04:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:14 INFO - 'MOZ_NO_REMOTE': '1', 04:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:14 INFO - 'NO_EM_RESTART': '1', 04:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:14 INFO - 'PWD': '/builds/slave/test', 04:10:14 INFO - 'SHELL': '/bin/bash', 04:10:14 INFO - 'SHLVL': '1', 04:10:14 INFO - 'TERM': 'linux', 04:10:14 INFO - 'TMOUT': '86400', 04:10:14 INFO - 'USER': 'cltbld', 04:10:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:14 INFO - '_': '/tools/buildbot/bin/python'} 04:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:14 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 04:10:14 INFO - Cleaning up... 04:10:14 INFO - Return code: 0 04:10:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:14 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:14 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 04:10:14 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 04:10:14 INFO - Using env: {'DISPLAY': ':0', 04:10:14 INFO - 'HOME': '/home/cltbld', 04:10:14 INFO - 'LANG': 'en_US.UTF-8', 04:10:14 INFO - 'LANGUAGE': 'en_US:en', 04:10:14 INFO - 'LOGNAME': 'cltbld', 04:10:14 INFO - 'MAIL': '/var/mail/cltbld', 04:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:14 INFO - 'MOZ_NO_REMOTE': '1', 04:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:14 INFO - 'NO_EM_RESTART': '1', 04:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:14 INFO - 'PWD': '/builds/slave/test', 04:10:14 INFO - 'SHELL': '/bin/bash', 04:10:14 INFO - 'SHLVL': '1', 04:10:14 INFO - 'TERM': 'linux', 04:10:14 INFO - 'TMOUT': '86400', 04:10:14 INFO - 'USER': 'cltbld', 04:10:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:14 INFO - '_': '/tools/buildbot/bin/python'} 04:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:14 INFO - Downloading/unpacking psutil>=3.1.1 04:10:14 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 04:10:14 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 04:10:14 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 04:10:14 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 04:10:14 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 04:10:14 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 04:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:16 INFO - Installing collected packages: psutil 04:10:16 INFO - Running setup.py install for psutil 04:10:16 INFO - building 'psutil._psutil_linux' extension 04:10:16 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 04:10:17 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 04:10:17 INFO - building 'psutil._psutil_posix' extension 04:10:17 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 04:10:17 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 04:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:17 INFO - Successfully installed psutil 04:10:17 INFO - Cleaning up... 04:10:17 INFO - Return code: 0 04:10:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:17 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 04:10:17 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 04:10:17 INFO - Using env: {'DISPLAY': ':0', 04:10:17 INFO - 'HOME': '/home/cltbld', 04:10:17 INFO - 'LANG': 'en_US.UTF-8', 04:10:17 INFO - 'LANGUAGE': 'en_US:en', 04:10:17 INFO - 'LOGNAME': 'cltbld', 04:10:17 INFO - 'MAIL': '/var/mail/cltbld', 04:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:17 INFO - 'MOZ_NO_REMOTE': '1', 04:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:17 INFO - 'NO_EM_RESTART': '1', 04:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:17 INFO - 'PWD': '/builds/slave/test', 04:10:17 INFO - 'SHELL': '/bin/bash', 04:10:17 INFO - 'SHLVL': '1', 04:10:17 INFO - 'TERM': 'linux', 04:10:17 INFO - 'TMOUT': '86400', 04:10:17 INFO - 'USER': 'cltbld', 04:10:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:17 INFO - '_': '/tools/buildbot/bin/python'} 04:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10:17 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 04:10:17 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 04:10:17 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 04:10:17 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 04:10:17 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 04:10:17 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 04:10:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:19 INFO - Installing collected packages: mozsystemmonitor 04:10:19 INFO - Running setup.py install for mozsystemmonitor 04:10:19 INFO - Successfully installed mozsystemmonitor 04:10:19 INFO - Cleaning up... 04:10:19 INFO - Return code: 0 04:10:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10:19 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')]} 04:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:19 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')]} 04:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:19 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:19 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 04:10:19 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 04:10:19 INFO - Using env: {'DISPLAY': ':0', 04:10:19 INFO - 'HOME': '/home/cltbld', 04:10:19 INFO - 'LANG': 'en_US.UTF-8', 04:10:19 INFO - 'LANGUAGE': 'en_US:en', 04:10:19 INFO - 'LOGNAME': 'cltbld', 04:10:19 INFO - 'MAIL': '/var/mail/cltbld', 04:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:19 INFO - 'MOZ_NO_REMOTE': '1', 04:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:19 INFO - 'NO_EM_RESTART': '1', 04:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:19 INFO - 'PWD': '/builds/slave/test', 04:10:19 INFO - 'SHELL': '/bin/bash', 04:10:19 INFO - 'SHLVL': '1', 04:10:19 INFO - 'TERM': 'linux', 04:10:19 INFO - 'TMOUT': '86400', 04:10:19 INFO - 'USER': 'cltbld', 04:10:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:19 INFO - '_': '/tools/buildbot/bin/python'} 04:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:21 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 04:10:21 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 04:10:21 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 04:10:21 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 04:10:21 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 04:10:21 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 04:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:22 INFO - Downloading docopt-0.6.1.tar.gz 04:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:22 INFO - Running setup.py install for blobuploader 04:10:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:22 INFO - Running setup.py install for requests 04:10:22 INFO - Running setup.py install for docopt 04:10:23 INFO - Successfully installed blobuploader requests docopt 04:10:23 INFO - Cleaning up... 04:10:23 INFO - Return code: 0 04:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:23 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')]} 04:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:23 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')]} 04:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:23 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:23 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 04:10:23 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 04:10:23 INFO - Using env: {'DISPLAY': ':0', 04:10:23 INFO - 'HOME': '/home/cltbld', 04:10:23 INFO - 'LANG': 'en_US.UTF-8', 04:10:23 INFO - 'LANGUAGE': 'en_US:en', 04:10:23 INFO - 'LOGNAME': 'cltbld', 04:10:23 INFO - 'MAIL': '/var/mail/cltbld', 04:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:23 INFO - 'MOZ_NO_REMOTE': '1', 04:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:23 INFO - 'NO_EM_RESTART': '1', 04:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:23 INFO - 'PWD': '/builds/slave/test', 04:10:23 INFO - 'SHELL': '/bin/bash', 04:10:23 INFO - 'SHLVL': '1', 04:10:23 INFO - 'TERM': 'linux', 04:10:23 INFO - 'TMOUT': '86400', 04:10:23 INFO - 'USER': 'cltbld', 04:10:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:23 INFO - '_': '/tools/buildbot/bin/python'} 04:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:23 INFO - Running setup.py (path:/tmp/pip-6A9y7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:23 INFO - Running setup.py (path:/tmp/pip-tf8kJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:23 INFO - Running setup.py (path:/tmp/pip-oe28wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:23 INFO - Running setup.py (path:/tmp/pip-eDtPTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:23 INFO - Running setup.py (path:/tmp/pip-EDc_GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:23 INFO - Running setup.py (path:/tmp/pip-jJ22br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:23 INFO - Running setup.py (path:/tmp/pip-HvFA9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:23 INFO - Running setup.py (path:/tmp/pip-frcJQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:23 INFO - Running setup.py (path:/tmp/pip-Vfc9E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:23 INFO - Running setup.py (path:/tmp/pip-SIJyFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:24 INFO - Running setup.py (path:/tmp/pip-N0KcgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:24 INFO - Running setup.py (path:/tmp/pip-ZQ3qHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:24 INFO - Running setup.py (path:/tmp/pip-2v1YvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:24 INFO - Running setup.py (path:/tmp/pip-RxWXGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:24 INFO - Running setup.py (path:/tmp/pip-iLkhxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:24 INFO - Running setup.py (path:/tmp/pip-4fRXxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:24 INFO - Running setup.py (path:/tmp/pip-5ivg5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:24 INFO - Running setup.py install for manifestparser 04:10:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:24 INFO - Running setup.py install for mozcrash 04:10:24 INFO - Running setup.py install for mozdebug 04:10:24 INFO - Running setup.py install for mozdevice 04:10:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozfile 04:10:25 INFO - Running setup.py install for mozhttpd 04:10:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozinfo 04:10:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozInstall 04:10:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozleak 04:10:25 INFO - Running setup.py install for mozlog 04:10:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for moznetwork 04:10:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozprocess 04:10:25 INFO - Running setup.py install for mozprofile 04:10:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:25 INFO - Running setup.py install for mozrunner 04:10:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Running setup.py install for mozscreenshot 04:10:26 INFO - Running setup.py install for moztest 04:10:26 INFO - Running setup.py install for mozversion 04:10:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:26 INFO - Cleaning up... 04:10:26 INFO - Return code: 0 04:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:26 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')]} 04:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:26 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')]} 04:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:26 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:26 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 04:10:26 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 04:10:26 INFO - Using env: {'DISPLAY': ':0', 04:10:26 INFO - 'HOME': '/home/cltbld', 04:10:26 INFO - 'LANG': 'en_US.UTF-8', 04:10:26 INFO - 'LANGUAGE': 'en_US:en', 04:10:26 INFO - 'LOGNAME': 'cltbld', 04:10:26 INFO - 'MAIL': '/var/mail/cltbld', 04:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:26 INFO - 'MOZ_NO_REMOTE': '1', 04:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:26 INFO - 'NO_EM_RESTART': '1', 04:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:26 INFO - 'PWD': '/builds/slave/test', 04:10:26 INFO - 'SHELL': '/bin/bash', 04:10:26 INFO - 'SHLVL': '1', 04:10:26 INFO - 'TERM': 'linux', 04:10:26 INFO - 'TMOUT': '86400', 04:10:26 INFO - 'USER': 'cltbld', 04:10:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:26 INFO - '_': '/tools/buildbot/bin/python'} 04:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:26 INFO - Running setup.py (path:/tmp/pip-BDhIQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:26 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)) 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:26 INFO - Running setup.py (path:/tmp/pip-QAmIgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:26 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)) 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:26 INFO - Running setup.py (path:/tmp/pip-Iq_uZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:26 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)) 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:26 INFO - Running setup.py (path:/tmp/pip-TPhxmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:26 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)) 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:26 INFO - Running setup.py (path:/tmp/pip-aazuH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:26 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)) 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:26 INFO - Running setup.py (path:/tmp/pip-Gwk_Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:27 INFO - Running setup.py (path:/tmp/pip-BXGa20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:27 INFO - Running setup.py (path:/tmp/pip-ReTwya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:27 INFO - Running setup.py (path:/tmp/pip-GWJzA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:27 INFO - Running setup.py (path:/tmp/pip-DSscaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:27 INFO - Running setup.py (path:/tmp/pip-CeKhaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:27 INFO - Running setup.py (path:/tmp/pip-Hftuae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:27 INFO - Running setup.py (path:/tmp/pip-SyYF8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:27 INFO - Running setup.py (path:/tmp/pip-XapgBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:27 INFO - Running setup.py (path:/tmp/pip-PNncsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:27 INFO - Running setup.py (path:/tmp/pip-D9mcPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:27 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)) 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:27 INFO - Running setup.py (path:/tmp/pip-QA53Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:27 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)) 04:10:27 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)) 04:10:27 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)) 04:10:27 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)) 04:10:27 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)) 04:10:27 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)) 04:10:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:29 INFO - Downloading blessings-1.6.tar.gz 04:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:29 INFO - Installing collected packages: blessings 04:10:29 INFO - Running setup.py install for blessings 04:10:29 INFO - Successfully installed blessings 04:10:29 INFO - Cleaning up... 04:10:29 INFO - Return code: 0 04:10:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:30 INFO - Reading from file tmpfile_stdout 04:10:30 INFO - Current package versions: 04:10:30 INFO - argparse == 1.2.1 04:10:30 INFO - blessings == 1.6 04:10:30 INFO - blobuploader == 1.2.4 04:10:30 INFO - docopt == 0.6.1 04:10:30 INFO - manifestparser == 1.1 04:10:30 INFO - mozInstall == 1.12 04:10:30 INFO - mozcrash == 0.17 04:10:30 INFO - mozdebug == 0.1 04:10:30 INFO - mozdevice == 0.48 04:10:30 INFO - mozfile == 1.2 04:10:30 INFO - mozhttpd == 0.7 04:10:30 INFO - mozinfo == 0.9 04:10:30 INFO - mozleak == 0.1 04:10:30 INFO - mozlog == 3.2 04:10:30 INFO - moznetwork == 0.27 04:10:30 INFO - mozprocess == 0.22 04:10:30 INFO - mozprofile == 0.28 04:10:30 INFO - mozrunner == 6.11 04:10:30 INFO - mozscreenshot == 0.1 04:10:30 INFO - mozsystemmonitor == 0.3 04:10:30 INFO - moztest == 0.7 04:10:30 INFO - mozversion == 1.4 04:10:30 INFO - psutil == 3.1.1 04:10:30 INFO - requests == 1.2.3 04:10:30 INFO - wsgiref == 0.1.2 04:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:30 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')]} 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:30 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')]} 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:30 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:30 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 04:10:30 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 04:10:30 INFO - Using env: {'DISPLAY': ':0', 04:10:30 INFO - 'HOME': '/home/cltbld', 04:10:30 INFO - 'LANG': 'en_US.UTF-8', 04:10:30 INFO - 'LANGUAGE': 'en_US:en', 04:10:30 INFO - 'LOGNAME': 'cltbld', 04:10:30 INFO - 'MAIL': '/var/mail/cltbld', 04:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:30 INFO - 'MOZ_NO_REMOTE': '1', 04:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:30 INFO - 'NO_EM_RESTART': '1', 04:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:30 INFO - 'PWD': '/builds/slave/test', 04:10:30 INFO - 'SHELL': '/bin/bash', 04:10:30 INFO - 'SHLVL': '1', 04:10:30 INFO - 'TERM': 'linux', 04:10:30 INFO - 'TMOUT': '86400', 04:10:30 INFO - 'USER': 'cltbld', 04:10:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:30 INFO - '_': '/tools/buildbot/bin/python'} 04:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 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)) 04:10:30 INFO - Cleaning up... 04:10:30 INFO - Return code: 0 04:10:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:30 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')]} 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:30 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')]} 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:30 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:30 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 04:10:30 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 04:10:30 INFO - Using env: {'DISPLAY': ':0', 04:10:30 INFO - 'HOME': '/home/cltbld', 04:10:30 INFO - 'LANG': 'en_US.UTF-8', 04:10:30 INFO - 'LANGUAGE': 'en_US:en', 04:10:30 INFO - 'LOGNAME': 'cltbld', 04:10:30 INFO - 'MAIL': '/var/mail/cltbld', 04:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:30 INFO - 'MOZ_NO_REMOTE': '1', 04:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:30 INFO - 'NO_EM_RESTART': '1', 04:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:30 INFO - 'PWD': '/builds/slave/test', 04:10:30 INFO - 'SHELL': '/bin/bash', 04:10:30 INFO - 'SHLVL': '1', 04:10:30 INFO - 'TERM': 'linux', 04:10:30 INFO - 'TMOUT': '86400', 04:10:30 INFO - 'USER': 'cltbld', 04:10:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:30 INFO - '_': '/tools/buildbot/bin/python'} 04:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:30 INFO - Downloading/unpacking jsonschema 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:32 INFO - warning: no files found matching '*.txt' 04:10:32 INFO - no previously-included directories found matching 'build' 04:10:32 INFO - no previously-included directories found matching 'dist' 04:10:32 INFO - no previously-included directories found matching '.git*' 04:10:32 INFO - Installing collected packages: jsonschema, functools32 04:10:32 INFO - Running setup.py install for functools32 04:10:32 INFO - warning: no files found matching '*.txt' 04:10:32 INFO - no previously-included directories found matching 'build' 04:10:32 INFO - no previously-included directories found matching 'dist' 04:10:32 INFO - no previously-included directories found matching '.git*' 04:10:32 INFO - Successfully installed jsonschema functools32 04:10:32 INFO - Cleaning up... 04:10:33 INFO - Return code: 0 04:10:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 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 0x7f8be67dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, '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': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', '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 04:10:33 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 04:10:33 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 04:10:33 INFO - Using env: {'DISPLAY': ':0', 04:10:33 INFO - 'HOME': '/home/cltbld', 04:10:33 INFO - 'LANG': 'en_US.UTF-8', 04:10:33 INFO - 'LANGUAGE': 'en_US:en', 04:10:33 INFO - 'LOGNAME': 'cltbld', 04:10:33 INFO - 'MAIL': '/var/mail/cltbld', 04:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:33 INFO - 'MOZ_NO_REMOTE': '1', 04:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:33 INFO - 'NO_EM_RESTART': '1', 04:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:33 INFO - 'PWD': '/builds/slave/test', 04:10:33 INFO - 'SHELL': '/bin/bash', 04:10:33 INFO - 'SHLVL': '1', 04:10:33 INFO - 'TERM': 'linux', 04:10:33 INFO - 'TMOUT': '86400', 04:10:33 INFO - 'USER': 'cltbld', 04:10:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:33 INFO - '_': '/tools/buildbot/bin/python'} 04:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:33 INFO - Downloading/unpacking flake8 04:10:33 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 04:10:33 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 04:10:33 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 04:10:33 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 04:10:33 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 04:10:33 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 04:10:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 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 04:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:35 INFO - no previously-included directories found matching 'docs/_build' 04:10:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:35 INFO - Running setup.py install for pep8 04:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:35 INFO - no previously-included directories found matching 'docs/_build' 04:10:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:35 INFO - Cleaning up... 04:10:36 INFO - Return code: 0 04:10:36 INFO - Running post-action listener: _resource_record_post_action 04:10:36 INFO - Running post-action listener: _start_resource_monitoring 04:10:36 INFO - Starting resource monitoring. 04:10:36 INFO - ##### 04:10:36 INFO - ##### Finished create-virtualenv step (success) 04:10:36 INFO - ##### 04:10:36 INFO - ##### 04:10:36 INFO - ##### Running install step. 04:10:36 INFO - ##### 04:10:36 INFO - Running pre-action listener: _resource_record_pre_action 04:10:36 INFO - Running main action method: install 04:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:36 INFO - Reading from file tmpfile_stdout 04:10:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:36 INFO - Reading from file tmpfile_stdout 04:10:36 INFO - Output received: 04:10:36 INFO - Usage: mozinstall [options] installer 04:10:36 INFO - Options: 04:10:36 INFO - -h, --help show this help message and exit 04:10:36 INFO - -d DEST, --destination=DEST 04:10:36 INFO - Directory to install application into. [default: 04:10:36 INFO - "/builds/slave/test"] 04:10:36 INFO - --app=APP Application being installed. [default: firefox] 04:10:36 INFO - mkdir: /builds/slave/test/build/application 04:10:36 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'] 04:10:36 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 04:10:52 INFO - Reading from file tmpfile_stdout 04:10:52 INFO - Output received: 04:10:52 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:52 INFO - Running post-action listener: _resource_record_post_action 04:10:52 INFO - ##### 04:10:52 INFO - ##### Finished install step (success) 04:10:52 INFO - ##### 04:10:52 INFO - ##### 04:10:52 INFO - ##### Running run-tests step. 04:10:52 INFO - ##### 04:10:52 INFO - Running pre-action listener: _resource_record_pre_action 04:10:52 INFO - Running main action method: run_tests 04:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:52 INFO - Python 2.7.3 04:10:52 INFO - Return code: 0 04:10:52 INFO - grabbing minidump binary from tooltool 04:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:52 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 0x26f79c0>, '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 0x26f88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:52 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 04:10:52 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 04:10:52 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 04:10:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:52 INFO - Return code: 0 04:10:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:10:53 INFO - Return code: 0 04:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 04:10:53 INFO - Using env: {'DISPLAY': ':0', 04:10:53 INFO - 'HOME': '/home/cltbld', 04:10:53 INFO - 'LANG': 'en_US.UTF-8', 04:10:53 INFO - 'LANGUAGE': 'en_US:en', 04:10:53 INFO - 'LOGNAME': 'cltbld', 04:10:53 INFO - 'MAIL': '/var/mail/cltbld', 04:10:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:53 INFO - 'MOZ_NO_REMOTE': '1', 04:10:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:53 INFO - 'NO_EM_RESTART': '1', 04:10:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:53 INFO - 'PWD': '/builds/slave/test', 04:10:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:53 INFO - 'SHELL': '/bin/bash', 04:10:53 INFO - 'SHLVL': '1', 04:10:53 INFO - 'TERM': 'linux', 04:10:53 INFO - 'TMOUT': '86400', 04:10:53 INFO - 'USER': 'cltbld', 04:10:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666', 04:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:53 INFO - '_': '/tools/buildbot/bin/python'} 04:10:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:10:53 INFO - mozversion application_buildid: 20160531025850 04:10:53 INFO - mozversion application_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 04:10:53 INFO - mozversion application_display_name: Nightly 04:10:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:53 INFO - mozversion application_name: Firefox 04:10:53 INFO - mozversion application_remotingname: firefox 04:10:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:10:53 INFO - mozversion application_vendor: Mozilla 04:10:53 INFO - mozversion application_version: 49.0a1 04:10:53 INFO - mozversion platform_buildid: 20160531025850 04:10:53 INFO - mozversion platform_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 04:10:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:10:53 INFO - mozversion platform_version: 49.0a1 04:10:53 INFO - using testdate: 1464693053 04:10:53 INFO - actual date: 1464693053 04:10:53 INFO - starting webserver on 'localhost:44501' 04:10:53 INFO - SUITE-START | Running 2 tests 04:10:53 INFO - TEST-START | dromaeo_css 04:10:53 INFO - operating with platform_type : linux_ 04:10:53 INFO - Initialising browser for dromaeo_css test... 04:10:53 INFO - TEST-INFO | started process 27401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePR1jC/profile http://localhost:44501/getInfo.html) 04:10:57 INFO - PROCESS | 27401 | __metrics Screen width/height:1600/1200 04:10:57 INFO - PROCESS | 27401 | colorDepth:24 04:10:57 INFO - PROCESS | 27401 | Browser inner width/height: 1024/697 04:10:57 INFO - PROCESS | 27401 | __metrics 04:10:58 ERROR - PROCESS | 27401 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:10:59 INFO - TEST-INFO | 27401: exit 0 04:10:59 INFO - Browser initialized. 04:10:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:59 INFO - TEST-INFO | started process 27483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePR1jC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:11 INFO - PROCESS | 27483 | RSS: Main: 157323264 04:11:11 INFO - PROCESS | 27483 | 04:12:03 INFO - PROCESS | 27483 | 1464693123076 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] 04:14:14 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44501/tests/dromaeo/cssquery-ext.html) 04:14:15 INFO - PROCESS | 27483 | RSS: Main: 231186432 04:14:15 INFO - PROCESS | 27483 | 04:17:18 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-ext.html (next: http://localhost:44501/tests/dromaeo/cssquery-jquery.html) 04:17:18 INFO - PROCESS | 27483 | RSS: Main: 238166016 04:17:18 INFO - PROCESS | 27483 | 04:20:20 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44501/tests/dromaeo/cssquery-mootools.html) 04:20:21 INFO - PROCESS | 27483 | RSS: Main: 237547520 04:20:21 INFO - PROCESS | 27483 | 04:23:23 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44501/tests/dromaeo/cssquery-prototype.html) 04:23:24 INFO - PROCESS | 27483 | RSS: Main: 242606080 04:23:24 INFO - PROCESS | 27483 | 04:26:26 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44501/tests/dromaeo/cssquery-yui.html) 04:26:27 INFO - PROCESS | 27483 | RSS: Main: 210292736 04:26:27 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | Cycle 1(1): loaded http://localhost:44501/tests/dromaeo/cssquery-yui.html (next: http://localhost:44501/tests/dromaeo/cssquery-dojo.html) 04:29:30 INFO - PROCESS | 27483 | RSS: Main: 272924672 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | __start_tp_report 04:29:30 INFO - PROCESS | 27483 | _x_x_mozilla_page_load 04:29:30 INFO - PROCESS | 27483 | _x_x_mozilla_page_load_details 04:29:30 INFO - PROCESS | 27483 | |i|pagename|runs| 04:29:30 INFO - PROCESS | 27483 | |0;dojo.html;2657.46850629874;2681.36987807865;2709.8238614490056;2721.9520484613417;2730.3856632257744;4638.605718513931;4706.764661766911;4721.527847215277;4784.2345224764085;4807.375041244638;4669.322948172513;4699.835505757299;4706.435227772672;4717.056588682261;4719.43366795985;4284.186004659113;4329.480462344523;4385.714928529651;4401.581849724271;4501.594856462918;4425.358323043157;4447.66642501812;4450.221211288028;4482.618977386926;4511.481179664332;4232.936505952413;4252.617264446215;4266.850660226877;4298.161858437606;4356.695031347807;4303.655707543389;4322.740635561876;4328.63206627437;4332.761698106603;4419.62433193179;4339.392485052095;4346;4359.171757366122;4402.779861006937;4404.11917616478;4472.418585583853;4555;4621.283701026313;4649.279361698942;4677.298405239208;5063.8480845574695;5086.3133476980875;5105.846824595268;5107.514786095315;5114.795408183668;5124.846254612367;5152.896942061137;5159.845204643867;5160.14857548504;5170.25031370453;4570.520095390003;4628.444586649556;4633.698809577367;4683.929741053887;4767.880802979953;5072.82245121419;5087.949120508748;5108.565771909355;5147.356580427447;5157.793688252428;4877;4904.8038078477175;4918.6556941014505;4927.334809800631;4970.602351811846;4904.4605093439695;4976.129177393942;5050.419201791841;5054.393472783216;5067.239914012854;4967.105920934267;5001.874953126201;5005.874853128628;5012.47369026247;5051.570616497565;4845.127876982177;4990.426100998432;5004.624653150955;5013.498650134958;5045.293658887758;4096.528899176633;4143.772092534879;4175.582441755861;4178.6657067434535;4236.894077648022;3690.6493883081066;3708.165662725865;3708.8887333380044;3743.026813028632;3752.681022113151;4345.283028300359;4352.542982986804;4361.869143925687;4367.170237654836;4410.184115938561;4947.90104197914;4978.950210497921;5029.044481548494;5040.840606660488;5049.091163590589;4300.397944287803;4302.698811083194;4318.5033721121845;4323.502797178302;4360;4454.510003899569;4513.571210734975;4513.571210734975;4521.389612402284;4554.316852472156;4810.350602668595;4866.562009419098;4885.169521181479;4893.755312234445;4894.2658601210105;5131.512506311894;5171.431142574389;5172.379314482287;5177.611679124006;5233.136532472099;4730.172219861579;4751.311059896365;4871.391076115486;4888.266759986031;4932.8520144395725;4926.802927882844;4943.2585112233455;4966.453690094015;4969.229769385751;5005.299258103795;4993.051320249141;5026.170681837456;5036.219385995177;5040.143175660073;5082.830948881852;4849.854504364875;4880.511948805091;4904.141775189399;4934.753262336941;4946.752662366939;4951.678140920829;4962.925556116589;4977.377827771528;4982.427020892644;5010.198368261061;4898.461169271306;4909.656324057281;4939.28380384835;4945.060438516671;4951.702897826142;4792.185328494234;4909.4845041270155;4959.70241785494;4967.03142887148;5034.119029169954;4862.489438609036;4879.512048795092;4885.389326334208;4887.0714564232685;4934.235193545006 04:29:30 INFO - PROCESS | 27483 | |1;ext.html;557.2045265484328;582.653321273842;596.8328867916982;597.8968802559276;598.7425407074959;27704.584431233547;40301.39547906784;41406;41475.377869331984;45617;39887.40168897461;40150.7992460038;40210.59789402105;40270;40310.59689403105;7490.775276741707;7631.313181813635;7637.618119094023;7642.617869106551;7643.961780191091;7690.961545192295;7824.530528168328;7827.608619569027;7829.021372328459;7830.138684744674;7804;7862.135165131831;7863.724769633064;7863.960680196619;7864.724734634289;7781.844363112735;7828.608569571498;7836.059672839296;7844.725434609818;7846.607669616496;7646.847063058708;7722.613869306569;7728.188540203254;7728.6908523658985;7730.806729831799;38433.615663843564;38664.226715465535;38921.41617875734;38951;38955.805220974;2861.4901099997464;2998.130542142776;3004.474217012036;3026.9243268918235;3084.228942764309;29922;30191.849040754874;30834.229144271347;31078.22304442407;31125.377492450025;3369.6124945631323;3373.713234375081;3374.5613070300706;3381.2730262993327;3410.5054767058637;249407;249925;250112.99999999817;250900;251376.99999999817;46094.76952615215;47622.76188619104;54843.45156548463;55217.723911380184;55271.44728552663;57306.696263410995;58844.705776470844;58985.41014589799;64362.356376436575;64592;14296.499622513162;14396.42414303437;14468.782968255484;14472.276386180649;14474.203918784568;9776.462294573867;11097.44512774358;11219.831702524469;11295.49170287339;11305.095592352756;16648.583785405463;17238.310467581407;17374.39189628357;17439.825601744073;17470.47588572345;6534.014251306699;6650;6656.077679213564;6747.561408508432;6804.8298792529595;729.4201110117469;845.2139510255398;974.8732664753537;1005.9849102263472;1016.2530540053203;27702.5844612331;27832.304192395353;28048.158555243375;28728.13815585536;28765.712342876723;900.6667533012827;936.4989730494153;956.2780101023683;1013.9746506337401;1021.1524434719165;14652.780208296885;14727.631809204855;14788.704225915422;15030.699386012218;15082.698346033018;358772;358927;360805;361016;361593;50235;50465.74767126141;50585.24122138171;50646.24030639543;50740;1055.8152323343384;1148.4430051425052;1161.3670549550516;1174.9412529373326;1195.9342236177094;27687.446251074463;28806.135815925554;28843;29159;29487.705122948497;42888.571114289705;47233.527664724286;48483.27275090806;48506.757466212446;53088.203676944104;341600;342871;347094;347800;347946;22615.208467703553;23729.64405533953;25184.49631007406;25213.87393063023;25676.743232568184;39597.80201098976;40233.396499053124;43685;44186.33720494131;44521.10957780891;36980.63019369772;37136.25727485489;37193.44209836909;38080.42879356867;38390;37007.259854802214;37213.25573488569;37221.813890930374;37594.248115037;37774.811125944194;36779.26441471209;36877.44683829691;37187.25625487529;37403.2519349606;37595.2480950374;31458.842705786323;33881.66118338884;33920.491192631634;33992.66007339895;34361.82819085888;25393.238202853943;25797.613035804854;25894.223173304832;26106.347341316618;26143.044410900347 04:29:30 INFO - PROCESS | 27483 | |2;jquery.html;357.3139572021717;361.3585885054029;365.7183968344373;373.9439084137379;376.76452217364147;15754.684906301882;16078.839211607881;16486.75269870953;17071.146442677862;17687.204075816586;15978.520644380658;16446.83553164468;16593.502194934143;16703.83296167038;16721.581960450996;4925.187344088221;5123.743812809364;5124.820631277906;5134.64057515974;5144.639875208737;3736.4768932349493;3945.940810887839;5131.589472842183;5731.140328950649;6056.3338032816355;6081.087836824468;6089.78685745999;6102.328743838174;6110.694465276741;6110.786122485714;5806.59353845231;5949.107633854913;6034.0948857671265;6087.847803804918;6112.358202388752;3374.1733275347697;4894.5105489451125;5102.69383836971;5165.767540460688;5197.090509160919;19984.90007549953;20821.37535873926;20824.375268741962;20881.164753409845;20884.686729699068;1743.6599863026715;1768.6993211154136;1870.6445775302784;1993.3421970749619;2417.7461366556436;8578.613962371708;9137.314701397421;9239.584218710173;11169.218154729173;13742.244176570284;1696.4316953820485;1714.6742118997352;1760.2255007796527;1822.5534743987675;1827.2234300422401;72174.63912680403;72908;73448.6327568364;73990.26009739887;74318.62840685816;9171.082891710908;9324;9362.297827662953;9373.906260937303;9405.247580193569;12533;12543.623691289276;12554.183978041397;12559.058070644556;12561.937190313989;7135.286471352823;7152.320529549685;7260.96369518149;7298.890516642255;7317.853642927112;6949.687264073129;6981.301869812978;6995.26549712283;7055.682494287769;7066.470014748915;3802.144517483544;3828.5214348206473;3864.8454061837774;3905.160390515996;4276.550962148992;1535.8233803112562;1575.7478803391402;1644.1943447710535;1652.702513547549;1667.8248783877762;746.6229554075265;757.6931342806172;794.3367288314207;885.8793626063035;950.0689324462066;16013.59966000836;16654.916725416297;16785.24466399015;17060.146992650567;17286;822.9094799572042;852.8464876322197;852.9914700853036;896.5830888636684;937.254882368505;9062.456252624863;9259.166674999282;9337.486438245962;9595.616175353047;9629.711108666752;367552;369677;375778;377627;378817;70996.2900371;72665;73413.632931835;73684;74432;909.3634455880909;946.9905300946903;957.0955447102422;959.5154447004358;959.7168835193635;15598.610034748768;15952;16099.678006439572;16290.67418651644;16392.262348194123;27858;33268;33611.83194084014;34624.13439663928;37871.621283787914;49193.50806492032;49681.75159124326;51522.22716659178;51589;52048.219276711636;6271.184745982993;6499.5775274607;6714.764983225564;6950.339717726808;7261.3101755333155;10244.795104097728;10827.891721083004;11005.944970275417;11274;11310.547578096784;9514;9681.66114186;9697.369670971646;9730.75673108178;10025.649102281384;9701.757456063655;9837.9016209837;9891.703248902544;9991.200703943812;10072.647457338959;5442.183672449164;6835.794926152024;9207.802985611828;9975.750606234611;10147.086762191439;6682.665866706742;6815.318468153145;6833.214180369321;6838.384545390939;6851.314868513308;9562.808743825224;9663.661771837951;9711.708648740549;9998.400095994264;10110.949445252727 04:29:30 INFO - PROCESS | 27483 | |3;mootools.html;1252.8872401483875;1424.7506686329893;1443.1052747296674;1583.2954335320787;1780.388748182895;7361.631918404085;7688.423368247383;7697.307242348187;7885.763427097182;7895.131535531087;7656.234376562341;7856.607169641524;7858.410619203554;7860.135385107648;7876.054873415198;2122.129926730041;2153.2786516516985;2154.6983422320886;2156.5255643758346;2158.3417057797365;2163.8593491423085;2195.034184958621;2232.7767223277706;2234.0728597631964;2235.6311208650554;2183.1267493002765;2183.235867446389;2211.1818627107914;2214.8228141748623;2215.523662412589;2145.1741079684357;2155.9245426410157;2163.6754486826944;2168.4145280774183;2168.4253672776726;2120.9045592948355;2163.7403511578555;2169.0889826272846;2169.316665250457;2172.0551560071262;7630.236976302381;7676.232376762335;7766.184550622216;7781.844363112706;7923.524588524707;4675.812967481296;4801.615870730333;4807.086653535852;4809.807607695723;4811.206150985084;2830.1085158175315;2963.7184467475554;3025.0924722583136;3026.4098500792356;3034.666186719459;902.1835239108551;903.6204793986476;919.967801126964;927.6660402255183;928.4011812381044;10625.681229563126;10698.983596558392;10726.731831704192;10752.247342686014;10759.62341318058;4128.690348223835;4143.357779544175;4201.054762678434;4202.978985105116;4204.726692764961;8461.11158328379;8501.14988501145;8509.702160424355;8519.403641745143;8525.57372131391;4378.0806030733265;4416.734995900256;4421.712588681789;4422.00504886398;4424.823007079681;3724.888253352404;4144.772037537904;4228.703990720682;4276.850310239127;4366.8034938427845;3419.743519236067;3441.3633477806684;3487.9128021799656;3506.50908872758;3655.7623754455876;1043.4886905416292;1046.8900765419673;1052.9262951593314;1056.3767377247461;1056.6513050693252;640.9743610255631;841.835842010802;844.8859403980507;859.3297228162044;865.2342676731013;4968.72672003036;4974.477679843637;4986.476419975923;5069.5690866276045;5335.413104558495;395.24310944540883;396.69882784466995;398.67707157202756;407.5964794853074;410.86441474313403;3483.5297234873474;3551.094470909953;3577.3918433866306;3592.7125829933543;3626.9274614507563;9384.108509691569;9725.416475011521;9745.12293893553;9748.610055597697;9751.024897510335;9429.952850235704;9499.38254013487;9503.57233924475;9567.282453815991;9673.12941835224;7347.302006309392;7389.224131466119;7406.037215161994;7425.1832298447125;7427.331540161412;4922.507749225048;4998.375203099613;5033.043721693013;5071.822486212965;5122.948770512247;8868.379213454997;8909.440847851729;8918;9028.954855225682;9052.818943621223;9026.45841249527;9126.908730912606;9182.632694692405;9286.442813431217;9316.860247096163;6151.753929842756;6178.227721534809;6234.220722409699;6248.843778905563;6259.029850373199;7303.525270857377;7324.523905946096;7349.081364829396;7349.853002940018;7362.4478164136835;6723.159605049369;6880.139982502187;6913.308669133247;6980;7023.929760702532;6487.1566696331065;6504;6635.4359879410795;6641.701123449359;6801.047853300641;6120.663363515049;6153.876922461436;6161.691915404302;6272.466840318624;6322.652254126067;4246.363045543193;4294.227039132986;4338.739675619473;4359.912801744011;4412.713173643703;4329.415528903558;4385.364122202199;4399.824007039811;4535.591796738309;4659.697119687209 04:29:30 INFO - PROCESS | 27483 | |4;prototype.html;287.8330568270403;294.45819691767156;294.74210066192086;298.85505529818033;301.2874551685262;4635.536446355362;4753.16819556578;4759.214729569621;4804.495527969565;4804.759762011903;4684.142672969494;4708.43498780146;4730.881727956803;4771.952280477194;4775.689580177294;3479.3389256041273;3548.1661809474754;3567.8572857085687;3707.7382796494117;3721.274351501458;3507.5615548056494;3598.622144674811;3601.891943241707;3613.620569840168;3630.52803135592;3610.620884807097;3619.1675914539674;3626.057225121461;3633.291508155911;3650.671439570438;3627.0413976452683;3630.6913912317486;3631.1648320886343;3644.5079914211506;3665.87169449068;3131.6555178930525;3182.199664295405;3205.6153261608524;3215.5980502437196;3216.7748257621975;4512.954870451286;4522.6155776759015;4525.298578720303;4530.909381812378;4547.386102876102;4109.794510274504;4122;4152.37714342848;4152.5432202457705;4156.459660244179;4726.409198850144;4889.168841296988;4892.263246547495;4934.679245849008;4949.78730211097;3440.2947395784054;3460.0657822387816;3466.9826650866585;3469.444888817802;3476.5828100628087;5190.584753219733;5204.531592156686;5209.348831396075;5213.7393130343335;5220.712860792655;3554.8222588870453;3562.839672214757;3574.5174401455993;3575.1777091269155;3596.8598683783107;3496.265784185299;3537.8407971641336;3600.3339382214376;3605.387084195693;3660.7254455915913;4081.6122518343905;4097.180563887175;4123.2165888481095;4123.402106694512;4127.628513433745;4916.5004673574185;4944.975275123601;4949;4965.82619608312;4986.202207646832;1217.701663092548;1222.394914517302;1231.2550906701497;1239.4174737873186;1242.2670624331688;784.3685832904453;791.216695471479;800.9279164875072;801.8155824160476;807.7455601485514;3902.980485097613;3976.3696884277306;4188.790560471964;4309.332053531708;4434.401355816988;5139.9417346678665;5151.845444636667;5154.5360917516855;5154.768035438415;5157.484251574888;4380.649548036149;4406.272964960745;4408.118376324748;4420.602145806893;4422.491413487426;2592.974070259311;2681.2358477833723;2710.7831373490467;2716.8913243470433;2723.6050772637855;4832.275158726219;4880.755962201947;4894.877628059256;4895.437024742129;4931.284963680247;5185.740712964337;5196.8307130896;5243.348345271227;5254.2940385701395;5270.868228294324;4739.322282910213;4739.38860787327;4834.347363105936;4851.296561998491;4857.344258525054;5041.495850414929;5063.885945092074;5072.5688316493515;5110.645678895022;5141.845744627667;5011;5038.858485143726;5039;5044.39467263916;5052.494750525065;4623.283391074388;4845.830395936126;4848.224284114524;4861.6596838220985;4868.513148685103;3496.59789124254;3521.1901262710235;3526.4357702767434;3531.099569609733;3546.7339949503375;5084.8220312288895;5116.8720781979255;5117.822900732778;5138.486151384832;5138.486151384981;4770.737609431515;4969.403671559436;4985;4998.225275082368;5006.274090256965;4977.950220497749;4996.625253105959;5000.799968001239;5001.64988450805;5010.173321401928;4923.950760492493;4946.356973593553;4946.554810067111;4949.183384741477;4975.4278258000795;4742.596879265163;4995.775190116381;5006.6495345325475;5017.37282839645;5035.546800787946;4886.951130488792;4894.241392584155;4895.845827835741;4899.461059283405;4905.411350637946 04:29:30 INFO - PROCESS | 27483 | |5;yui.html;562.5021855657742;574.586297865537;581.4127730991697;664.5372467193416;668.8395633575745;9760.85358719618;11519.596814111508;12210.572629957953;12355.50577976881;12359.258444493336;12270.509179632827;12733.61799146027;12800.167989080703;12806.67983300418;12813.615591532245;626.4549841637781;780.4575819805237;787.3740376400775;788.3023524181084;790.8339248757768;787.7991112266365;792.9841403171934;793.817421992942;793.9245771651683;794.9602519874012;834.2241715204888;835.1690068381938;839.2488722593275;839.5172775653992;839.7690635075342;825.8637324841394;826.7189155687096;829.4981536170591;831.0526000359534;831.9792005199857;608.2913405882142;610.8778244351103;615.4153554123601;615.4922189193933;615.5506480269383;11584;11679;11684.47419866108;11686.24039437434;11729;11937;12188.756224875453;12408;12536.623901282976;12548.1216314858;10118.340240675103;10158.238132140119;10257.43584102874;10409;10664.946675266652;3304.8182349970743;3324.2188085800058;3353.782004169721;3383.5601371821754;3453.3438646657055;48575.514244857804;48740;49064;50421.49578504205;50851.23723144119;9600.615975360908;9943.045563549276;10114.494275286354;10146.797064058677;10227.590896364061;17279.827201728072;17319.65360692779;17328.133593320283;17338;17363.392281270095;6596.406323430819;6731.124953755981;6784.3554862288;6935.583864968118;7070.646467676595;3497.405441075023;3542.8009867033147;3556.91107722309;3575.284943011408;3611.8870460780736;2907.5057240269207;3020.8036477628884;3022.45595792755;3025.9546106808416;3026.5914101596004;497.6541303793829;501.7591556053115;506.0360014173006;515.4330236739556;521.5514657394638;480.219643079995;500.33752928563297;548.1749966300772;583.291301069203;586.8767558812697;7527.305961614235;7584.658690358947;7695.422843286776;7717.498362606412;7759.844803104019;519.5687579309164;555.5056000159781;578.563333797243;589.0251633546487;596.2546816479401;3518.7360947928496;3528.400171970771;3558.839852206657;3666.3400587894434;3673.412254039341;58405.415945839995;58864.41135588675;60800.69599651973;60843.695781521696;60940.39059609436;52968.90857551354;53030.204546931825;53989.3139815383;54153;54159;49090.50909490931;49214;49642.50357496379;49996;50033.49966500361;7426.554406735613;7481.1732065001115;7665.88501172494;7715.691372345043;7866.528008319519;29739.851300743358;29875.701242987292;30150.54774178345;30722.846385767927;31175.220619484695;39543.40684889672;39854.2029159421;39913.600863990985;39973.40039899462;41194.58805412027;10137.543810528692;10770.299930504492;10849.240553161519;10853.186011049045;11050.889491104987;10375.169986400919;10698;11379.829302560303;11871.584494542649;12103.394830258629;10859.674209773719;10919.071878890383;10935.890641093805;10959.835602466128;10982.780344393228;10051.949740251252;10196.4391958443;10605.840912386166;10824.729381765204;11159.27464714791;10791.514381852678;11199.88800112021;11202.04782593456;11233;11382.829257561309;8955.507447090473;9081.636734530544;9115.225205857576;9277.814443711222;9369.390989585656;8731.519766412654;8920.197182253629;9105.135012173832;9148.496832674267;9359.906400936175 04:29:30 INFO - PROCESS | 27483 | __end_tp_report 04:29:30 INFO - PROCESS | 27483 | __start_cc_report 04:29:30 INFO - PROCESS | 27483 | _x_x_mozilla_cycle_collect,1031 04:29:30 INFO - PROCESS | 27483 | __end_cc_report 04:29:30 INFO - PROCESS | 27483 | __startTimestamp1464694170340__endTimestamp 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | ------- Summary: start ------- 04:29:30 INFO - PROCESS | 27483 | Number of tests: 6 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#0] dojo.html Cycles:165 Average:4670.08 Median:4866.56 stddev:488.10 (10.0%) stddev-sans-first:463.36 04:29:30 INFO - PROCESS | 27483 | Values: 2657.5 2681.4 2709.8 2722.0 2730.4 4638.6 4706.8 4721.5 4784.2 4807.4 4669.3 4699.8 4706.4 4717.1 4719.4 4284.2 4329.5 4385.7 4401.6 4501.6 4425.4 4447.7 4450.2 4482.6 4511.5 4232.9 4252.6 4266.9 4298.2 4356.7 4303.7 4322.7 4328.6 4332.8 4419.6 4339.4 4346.0 4359.2 4402.8 4404.1 4472.4 4555.0 4621.3 4649.3 4677.3 5063.8 5086.3 5105.8 5107.5 5114.8 5124.8 5152.9 5159.8 5160.1 5170.3 4570.5 4628.4 4633.7 4683.9 4767.9 5072.8 5087.9 5108.6 5147.4 5157.8 4877.0 4904.8 4918.7 4927.3 4970.6 4904.5 4976.1 5050.4 5054.4 5067.2 4967.1 5001.9 5005.9 5012.5 5051.6 4845.1 4990.4 5004.6 5013.5 5045.3 4096.5 4143.8 4175.6 4178.7 4236.9 3690.6 3708.2 3708.9 3743.0 3752.7 4345.3 4352.5 4361.9 4367.2 4410.2 4947.9 4979.0 5029.0 5040.8 5049.1 4300.4 4302.7 4318.5 4323.5 4360.0 4454.5 4513.6 4513.6 4521.4 4554.3 4810.4 4866.6 4885.2 4893.8 4894.3 5131.5 5171.4 5172.4 5177.6 5233.1 4730.2 4751.3 4871.4 4888.3 4932.9 4926.8 4943.3 4966.5 4969.2 5005.3 4993.1 5026.2 5036.2 5040.1 5082.8 4849.9 4880.5 4904.1 4934.8 4946.8 4951.7 4962.9 4977.4 4982.4 5010.2 4898.5 4909.7 4939.3 4945.1 4951.7 4792.2 4909.5 4959.7 4967.0 5034.1 4862.5 4879.5 4885.4 4887.1 4934.2 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#1] ext.html Cycles:180 Average:47901.48 Median:37203.35 stddev:84782.22 (227.9%) stddev-sans-first:84945.53 04:29:30 INFO - PROCESS | 27483 | Values: 557.2 582.7 596.8 597.9 598.7 27704.6 40301.4 41406.0 41475.4 45617.0 39887.4 40150.8 40210.6 40270.0 40310.6 7490.8 7631.3 7637.6 7642.6 7644.0 7691.0 7824.5 7827.6 7829.0 7830.1 7804.0 7862.1 7863.7 7864.0 7864.7 7781.8 7828.6 7836.1 7844.7 7846.6 7646.8 7722.6 7728.2 7728.7 7730.8 38433.6 38664.2 38921.4 38951.0 38955.8 2861.5 2998.1 3004.5 3026.9 3084.2 29922.0 30191.8 30834.2 31078.2 31125.4 3369.6 3373.7 3374.6 3381.3 3410.5 249407.0 249925.0 250113.0 250900.0 251377.0 46094.8 47622.8 54843.5 55217.7 55271.4 57306.7 58844.7 58985.4 64362.4 64592.0 14296.5 14396.4 14468.8 14472.3 14474.2 9776.5 11097.4 11219.8 11295.5 11305.1 16648.6 17238.3 17374.4 17439.8 17470.5 6534.0 6650.0 6656.1 6747.6 6804.8 729.4 845.2 974.9 1006.0 1016.3 27702.6 27832.3 28048.2 28728.1 28765.7 900.7 936.5 956.3 1014.0 1021.2 14652.8 14727.6 14788.7 15030.7 15082.7 358772.0 358927.0 360805.0 361016.0 361593.0 50235.0 50465.7 50585.2 50646.2 50740.0 1055.8 1148.4 1161.4 1174.9 1195.9 27687.4 28806.1 28843.0 29159.0 29487.7 42888.6 47233.5 48483.3 48506.8 53088.2 341600.0 342871.0 347094.0 347800.0 347946.0 22615.2 23729.6 25184.5 25213.9 25676.7 39597.8 40233.4 43685.0 44186.3 44521.1 36980.6 37136.3 37193.4 38080.4 38390.0 37007.3 37213.3 37221.8 37594.2 37774.8 36779.3 36877.4 37187.3 37403.3 37595.2 31458.8 33881.7 33920.5 33992.7 34361.8 25393.2 25797.6 25894.2 26106.3 26143.0 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#2] jquery.html Cycles:180 Average:23566.92 Median:28377.38 stddev:61874.67 (218.0%) stddev-sans-first:62023.70 04:29:30 INFO - PROCESS | 27483 | Values: 357.3 361.4 365.7 373.9 376.8 15754.7 16078.8 16486.8 17071.1 17687.2 15978.5 16446.8 16593.5 16703.8 16721.6 4925.2 5123.7 5124.8 5134.6 5144.6 3736.5 3945.9 5131.6 5731.1 6056.3 6081.1 6089.8 6102.3 6110.7 6110.8 5806.6 5949.1 6034.1 6087.8 6112.4 3374.2 4894.5 5102.7 5165.8 5197.1 19984.9 20821.4 20824.4 20881.2 20884.7 1743.7 1768.7 1870.6 1993.3 2417.7 8578.6 9137.3 9239.6 11169.2 13742.2 1696.4 1714.7 1760.2 1822.6 1827.2 72174.6 72908.0 73448.6 73990.3 74318.6 9171.1 9324.0 9362.3 9373.9 9405.2 12533.0 12543.6 12554.2 12559.1 12561.9 7135.3 7152.3 7261.0 7298.9 7317.9 6949.7 6981.3 6995.3 7055.7 7066.5 3802.1 3828.5 3864.8 3905.2 4276.6 1535.8 1575.7 1644.2 1652.7 1667.8 746.6 757.7 794.3 885.9 950.1 16013.6 16654.9 16785.2 17060.1 17286.0 822.9 852.8 853.0 896.6 937.3 9062.5 9259.2 9337.5 9595.6 9629.7 367552.0 369677.0 375778.0 377627.0 378817.0 70996.3 72665.0 73413.6 73684.0 74432.0 909.4 947.0 957.1 959.5 959.7 15598.6 15952.0 16099.7 16290.7 16392.3 27858.0 33268.0 33611.8 34624.1 37871.6 49193.5 49681.8 51522.2 51589.0 52048.2 6271.2 6499.6 6714.8 6950.3 7261.3 10244.8 10827.9 11005.9 11274.0 11310.5 9514.0 9681.7 9697.4 9730.8 10025.6 9701.8 9837.9 9891.7 9991.2 10072.6 5442.2 6835.8 9207.8 9975.8 10147.1 6682.7 6815.3 6833.2 6838.4 6851.3 9562.8 9663.7 9711.7 9998.4 10110.9 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#3] mootools.html Cycles:180 Average:5070.39 Median:4945.62 stddev:2884.52 (58.3%) stddev-sans-first:2878.34 04:29:30 INFO - PROCESS | 27483 | Values: 1252.9 1424.8 1443.1 1583.3 1780.4 7361.6 7688.4 7697.3 7885.8 7895.1 7656.2 7856.6 7858.4 7860.1 7876.1 2122.1 2153.3 2154.7 2156.5 2158.3 2163.9 2195.0 2232.8 2234.1 2235.6 2183.1 2183.2 2211.2 2214.8 2215.5 2145.2 2155.9 2163.7 2168.4 2168.4 2120.9 2163.7 2169.1 2169.3 2172.1 7630.2 7676.2 7766.2 7781.8 7923.5 4675.8 4801.6 4807.1 4809.8 4811.2 2830.1 2963.7 3025.1 3026.4 3034.7 902.2 903.6 920.0 927.7 928.4 10625.7 10699.0 10726.7 10752.2 10759.6 4128.7 4143.4 4201.1 4203.0 4204.7 8461.1 8501.1 8509.7 8519.4 8525.6 4378.1 4416.7 4421.7 4422.0 4424.8 3724.9 4144.8 4228.7 4276.9 4366.8 3419.7 3441.4 3487.9 3506.5 3655.8 1043.5 1046.9 1052.9 1056.4 1056.7 641.0 841.8 844.9 859.3 865.2 4968.7 4974.5 4986.5 5069.6 5335.4 395.2 396.7 398.7 407.6 410.9 3483.5 3551.1 3577.4 3592.7 3626.9 9384.1 9725.4 9745.1 9748.6 9751.0 9430.0 9499.4 9503.6 9567.3 9673.1 7347.3 7389.2 7406.0 7425.2 7427.3 4922.5 4998.4 5033.0 5071.8 5122.9 8868.4 8909.4 8918.0 9029.0 9052.8 9026.5 9126.9 9182.6 9286.4 9316.9 6151.8 6178.2 6234.2 6248.8 6259.0 7303.5 7324.5 7349.1 7349.9 7362.4 6723.2 6880.1 6913.3 6980.0 7023.9 6487.2 6504.0 6635.4 6641.7 6801.0 6120.7 6153.9 6161.7 6272.5 6322.7 4246.4 4294.2 4338.7 4359.9 4412.7 4329.4 4385.4 4399.8 4535.6 4659.7 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#4] prototype.html Cycles:180 Average:4098.51 Median:4735.10 stddev:1216.20 (25.7%) stddev-sans-first:1185.50 04:29:30 INFO - PROCESS | 27483 | Values: 287.8 294.5 294.7 298.9 301.3 4635.5 4753.2 4759.2 4804.5 4804.8 4684.1 4708.4 4730.9 4772.0 4775.7 3479.3 3548.2 3567.9 3707.7 3721.3 3507.6 3598.6 3601.9 3613.6 3630.5 3610.6 3619.2 3626.1 3633.3 3650.7 3627.0 3630.7 3631.2 3644.5 3665.9 3131.7 3182.2 3205.6 3215.6 3216.8 4513.0 4522.6 4525.3 4530.9 4547.4 4109.8 4122.0 4152.4 4152.5 4156.5 4726.4 4889.2 4892.3 4934.7 4949.8 3440.3 3460.1 3467.0 3469.4 3476.6 5190.6 5204.5 5209.3 5213.7 5220.7 3554.8 3562.8 3574.5 3575.2 3596.9 3496.3 3537.8 3600.3 3605.4 3660.7 4081.6 4097.2 4123.2 4123.4 4127.6 4916.5 4945.0 4949.0 4965.8 4986.2 1217.7 1222.4 1231.3 1239.4 1242.3 784.4 791.2 800.9 801.8 807.7 3903.0 3976.4 4188.8 4309.3 4434.4 5139.9 5151.8 5154.5 5154.8 5157.5 4380.6 4406.3 4408.1 4420.6 4422.5 2593.0 2681.2 2710.8 2716.9 2723.6 4832.3 4880.8 4894.9 4895.4 4931.3 5185.7 5196.8 5243.3 5254.3 5270.9 4739.3 4739.4 4834.3 4851.3 4857.3 5041.5 5063.9 5072.6 5110.6 5141.8 5011.0 5038.9 5039.0 5044.4 5052.5 4623.3 4845.8 4848.2 4861.7 4868.5 3496.6 3521.2 3526.4 3531.1 3546.7 5084.8 5116.9 5117.8 5138.5 5138.5 4770.7 4969.4 4985.0 4998.2 5006.3 4978.0 4996.6 5000.8 5001.6 5010.2 4924.0 4946.4 4946.6 4949.2 4975.4 4742.6 4995.8 5006.6 5017.4 5035.5 4887.0 4894.2 4895.8 4899.5 4905.4 04:29:30 INFO - PROCESS | 27483 | 04:29:30 INFO - PROCESS | 27483 | [#5] yui.html Cycles:180 Average:13436.92 Median:49077.25 stddev:16282.28 (33.2%) stddev-sans-first:16299.26 04:29:30 INFO - PROCESS | 27483 | Values: 562.5 574.6 581.4 664.5 668.8 9760.9 11519.6 12210.6 12355.5 12359.3 12270.5 12733.6 12800.2 12806.7 12813.6 626.5 780.5 787.4 788.3 790.8 787.8 793.0 793.8 793.9 795.0 834.2 835.2 839.2 839.5 839.8 825.9 826.7 829.5 831.1 832.0 608.3 610.9 615.4 615.5 615.6 11584.0 11679.0 11684.5 11686.2 11729.0 11937.0 12188.8 12408.0 12536.6 12548.1 10118.3 10158.2 10257.4 10409.0 10664.9 3304.8 3324.2 3353.8 3383.6 3453.3 48575.5 48740.0 49064.0 50421.5 50851.2 9600.6 9943.0 10114.5 10146.8 10227.6 17279.8 17319.7 17328.1 17338.0 17363.4 6596.4 6731.1 6784.4 6935.6 7070.6 3497.4 3542.8 3556.9 3575.3 3611.9 2907.5 3020.8 3022.5 3026.0 3026.6 497.7 501.8 506.0 515.4 521.6 480.2 500.3 548.2 583.3 586.9 7527.3 7584.7 7695.4 7717.5 7759.8 519.6 555.5 578.6 589.0 596.3 3518.7 3528.4 3558.8 3666.3 3673.4 58405.4 58864.4 60800.7 60843.7 60940.4 52968.9 53030.2 53989.3 54153.0 54159.0 49090.5 49214.0 49642.5 49996.0 50033.5 7426.6 7481.2 7665.9 7715.7 7866.5 29739.9 29875.7 30150.5 30722.8 31175.2 39543.4 39854.2 39913.6 39973.4 41194.6 10137.5 10770.3 10849.2 10853.2 11050.9 10375.2 10698.0 11379.8 11871.6 12103.4 10859.7 10919.1 10935.9 10959.8 10982.8 10051.9 10196.4 10605.8 10824.7 11159.3 10791.5 11199.9 11202.0 11233.0 11382.8 8955.5 9081.6 9115.2 9277.8 9369.4 8731.5 8920.2 9105.1 9148.5 9359.9 04:29:30 INFO - PROCESS | 27483 | -------- Summary: end -------- 04:29:30 INFO - PROCESS | 27483 | 04:29:31 INFO - TEST-INFO | 27483: exit 0 04:29:31 INFO - TEST-OK | dromaeo_css | took 1117725ms 04:29:31 INFO - TEST-START | kraken 04:29:31 INFO - operating with platform_type : linux_ 04:29:31 INFO - Initialising browser for kraken test... 04:29:31 INFO - TEST-INFO | started process 27662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqL75e/profile http://localhost:44501/getInfo.html) 04:29:35 INFO - PROCESS | 27662 | __metrics Screen width/height:1600/1200 04:29:35 INFO - PROCESS | 27662 | colorDepth:24 04:29:35 INFO - PROCESS | 27662 | Browser inner width/height: 1024/697 04:29:35 INFO - PROCESS | 27662 | __metrics 04:29:36 ERROR - PROCESS | 27662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:29:37 INFO - TEST-INFO | 27662: exit 0 04:29:37 INFO - Browser initialized. 04:29:37 INFO - Running cycle 1/1 for kraken test... 04:29:37 INFO - TEST-INFO | started process 27744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqL75e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:49 INFO - PROCESS | 27744 | RSS: Main: 157106176 04:29:49 INFO - PROCESS | 27744 | 04:29:51 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:52 INFO - PROCESS | 27744 | RSS: Main: 215711744 04:29:52 INFO - PROCESS | 27744 | 04:29:55 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-dft) 04:29:56 INFO - PROCESS | 27744 | RSS: Main: 203735040 04:29:56 INFO - PROCESS | 27744 | 04:29:59 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-fft) 04:30:00 INFO - PROCESS | 27744 | RSS: Main: 270524416 04:30:00 INFO - PROCESS | 27744 | 04:30:02 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44501/tests/kraken/driver.html?testName=audio-oscillator) 04:30:02 INFO - PROCESS | 27744 | RSS: Main: 180600832 04:30:02 INFO - PROCESS | 27744 | 04:30:05 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:05 INFO - PROCESS | 27744 | RSS: Main: 185303040 04:30:05 INFO - PROCESS | 27744 | 04:30:08 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:09 INFO - PROCESS | 27744 | RSS: Main: 221528064 04:30:09 INFO - PROCESS | 27744 | 04:30:13 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44501/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:13 INFO - PROCESS | 27744 | RSS: Main: 216903680 04:30:13 INFO - PROCESS | 27744 | 04:30:16 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44501/tests/kraken/driver.html?testName=json-parse-financial) 04:30:17 INFO - PROCESS | 27744 | RSS: Main: 219148288 04:30:17 INFO - PROCESS | 27744 | 04:30:18 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:19 INFO - PROCESS | 27744 | RSS: Main: 208367616 04:30:19 INFO - PROCESS | 27744 | 04:30:21 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:22 INFO - PROCESS | 27744 | RSS: Main: 211632128 04:30:22 INFO - PROCESS | 27744 | 04:30:24 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:25 INFO - PROCESS | 27744 | RSS: Main: 217944064 04:30:25 INFO - PROCESS | 27744 | 04:30:27 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:28 INFO - PROCESS | 27744 | RSS: Main: 225214464 04:30:28 INFO - PROCESS | 27744 | 04:30:31 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:31 INFO - PROCESS | 27744 | RSS: Main: 224415744 04:30:31 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | Cycle 1(1): loaded http://localhost:44501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44501/tests/kraken/driver.html?testName=ai-astar) 04:30:33 INFO - PROCESS | 27744 | RSS: Main: 266817536 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | __start_tp_report 04:30:33 INFO - PROCESS | 27744 | _x_x_mozilla_page_load 04:30:33 INFO - PROCESS | 27744 | _x_x_mozilla_page_load_details 04:30:33 INFO - PROCESS | 27744 | |i|pagename|runs| 04:30:33 INFO - PROCESS | 27744 | |0;ai-astar;115;109;114;114;115;114;114;113;114;113 04:30:33 INFO - PROCESS | 27744 | |1;audio-beat-detection;170;131;141;183;139;162;155;134;206;133 04:30:33 INFO - PROCESS | 27744 | |2;audio-dft;162;163;161;162;161;162;163;160;162;162 04:30:33 INFO - PROCESS | 27744 | |3;audio-fft;76;77;76;121;77;76;75;75;99;76 04:30:33 INFO - PROCESS | 27744 | |4;audio-oscillator;85;84;115;84;84;83;123;85;85;133 04:30:33 INFO - PROCESS | 27744 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 04:30:33 INFO - PROCESS | 27744 | |6;imaging-darkroom;146;146;147;146;146;147;147;146;146;148 04:30:33 INFO - PROCESS | 27744 | |7;imaging-desaturate;94;94;95;95;95;94;95;95;95;95 04:30:33 INFO - PROCESS | 27744 | |8;json-parse-financial;63;64;63;62;62;62;63;63;63;62 04:30:33 INFO - PROCESS | 27744 | |9;json-stringify-tinderbox;64;65;64;64;65;64;65;65;65;64 04:30:33 INFO - PROCESS | 27744 | |10;stanford-crypto-aes;96;84;91;85;86;89;87;84;139;91 04:30:33 INFO - PROCESS | 27744 | |11;stanford-crypto-ccm;143;139;129;129;128;128;134;130;146;133 04:30:33 INFO - PROCESS | 27744 | |12;stanford-crypto-pbkdf2;177;169;170;170;171;172;169;173;171;174 04:30:33 INFO - PROCESS | 27744 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;66;66;67;70;65 04:30:33 INFO - PROCESS | 27744 | __end_tp_report 04:30:33 INFO - PROCESS | 27744 | __start_cc_report 04:30:33 INFO - PROCESS | 27744 | _x_x_mozilla_cycle_collect,1879 04:30:33 INFO - PROCESS | 27744 | __end_cc_report 04:30:33 INFO - PROCESS | 27744 | __startTimestamp1464694233888__endTimestamp 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | ------- Summary: start ------- 04:30:33 INFO - PROCESS | 27744 | Number of tests: 14 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.72 (1.5%) stddev-sans-first:1.73 04:30:33 INFO - PROCESS | 27744 | Values: 115.0 109.0 114.0 114.0 115.0 114.0 114.0 113.0 114.0 113.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:158.50 stddev:24.97 (15.8%) stddev-sans-first:25.92 04:30:33 INFO - PROCESS | 27744 | Values: 170.0 131.0 141.0 183.0 139.0 162.0 155.0 134.0 206.0 133.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 04:30:33 INFO - PROCESS | 27744 | Values: 162.0 163.0 161.0 162.0 161.0 162.0 163.0 160.0 162.0 162.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:15.26 (20.1%) stddev-sans-first:15.99 04:30:33 INFO - PROCESS | 27744 | Values: 76.0 77.0 76.0 121.0 77.0 76.0 75.0 75.0 99.0 76.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.00 stddev:19.50 (23.2%) stddev-sans-first:20.27 04:30:33 INFO - PROCESS | 27744 | Values: 85.0 84.0 115.0 84.0 84.0 83.0 123.0 85.0 85.0 133.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:30:33 INFO - PROCESS | 27744 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:30:33 INFO - PROCESS | 27744 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:30:33 INFO - PROCESS | 27744 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:30:33 INFO - PROCESS | 27744 | Values: 63.0 64.0 63.0 62.0 62.0 62.0 63.0 63.0 63.0 62.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:30:33 INFO - PROCESS | 27744 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.00 stddev:16.53 (18.8%) stddev-sans-first:17.50 04:30:33 INFO - PROCESS | 27744 | Values: 96.0 84.0 91.0 85.0 86.0 89.0 87.0 84.0 139.0 91.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:133.50 stddev:6.57 (4.9%) stddev-sans-first:6.09 04:30:33 INFO - PROCESS | 27744 | Values: 143.0 139.0 129.0 129.0 128.0 128.0 134.0 130.0 146.0 133.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.50 (1.5%) stddev-sans-first:1.73 04:30:33 INFO - PROCESS | 27744 | Values: 177.0 169.0 170.0 170.0 171.0 172.0 169.0 173.0 171.0 174.0 04:30:33 INFO - PROCESS | 27744 | 04:30:33 INFO - PROCESS | 27744 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 04:30:33 INFO - PROCESS | 27744 | Values: 68.0 66.0 67.0 67.0 66.0 66.0 66.0 67.0 70.0 65.0 04:30:33 INFO - PROCESS | 27744 | -------- Summary: end -------- 04:30:33 INFO - PROCESS | 27744 | 04:30:34 INFO - TEST-INFO | 27744: exit 0 04:30:34 INFO - TEST-OK | kraken | took 63753ms 04:30:34 INFO - SUITE-END | took 1181s 04:30:35 INFO - Completed test suite (00:19:41) 04:30:35 INFO - javascript benchmark 04:30:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.46850629874, 2681.36987807865, 2709.8238614490056, 2721.9520484613417, 2730.3856632257744, 4638.605718513931, 4706.764661766911, 4721.527847215277, 4784.2345224764085, 4807.375041244638, 4669.322948172513, 4699.835505757299, 4706.435227772672, 4717.056588682261, 4719.43366795985, 4284.186004659113, 4329.480462344523, 4385.714928529651, 4401.581849724271, 4501.594856462918, 4425.358323043157, 4447.66642501812, 4450.221211288028, 4482.618977386926, 4511.481179664332, 4232.936505952413, 4252.617264446215, 4266.850660226877, 4298.161858437606, 4356.695031347807, 4303.655707543389, 4322.740635561876, 4328.63206627437, 4332.761698106603, 4419.62433193179, 4339.392485052095, 4346.0, 4359.171757366122, 4402.779861006937, 4404.11917616478, 4472.418585583853, 4555.0, 4621.283701026313, 4649.279361698942, 4677.298405239208, 5063.8480845574695, 5086.3133476980875, 5105.846824595268, 5107.514786095315, 5114.795408183668, 5124.846254612367, 5152.896942061137, 5159.845204643867, 5160.14857548504, 5170.25031370453, 4570.520095390003, 4628.444586649556, 4633.698809577367, 4683.929741053887, 4767.880802979953, 5072.82245121419, 5087.949120508748, 5108.565771909355, 5147.356580427447, 5157.793688252428, 4877.0, 4904.8038078477175, 4918.6556941014505, 4927.334809800631, 4970.602351811846, 4904.4605093439695, 4976.129177393942, 5050.419201791841, 5054.393472783216, 5067.239914012854, 4967.105920934267, 5001.874953126201, 5005.874853128628, 5012.47369026247, 5051.570616497565, 4845.127876982177, 4990.426100998432, 5004.624653150955, 5013.498650134958, 5045.293658887758, 4096.528899176633, 4143.772092534879, 4175.582441755861, 4178.6657067434535, 4236.894077648022, 3690.6493883081066, 3708.165662725865, 3708.8887333380044, 3743.026813028632, 3752.681022113151, 4345.283028300359, 4352.542982986804, 4361.869143925687, 4367.170237654836, 4410.184115938561, 4947.90104197914, 4978.950210497921, 5029.044481548494, 5040.840606660488, 5049.091163590589, 4300.397944287803, 4302.698811083194, 4318.5033721121845, 4323.502797178302, 4360.0, 4454.510003899569, 4513.571210734975, 4513.571210734975, 4521.389612402284, 4554.316852472156, 4810.350602668595, 4866.562009419098, 4885.169521181479, 4893.755312234445, 4894.2658601210105, 5131.512506311894, 5171.431142574389, 5172.379314482287, 5177.611679124006, 5233.136532472099, 4730.172219861579, 4751.311059896365, 4871.391076115486, 4888.266759986031, 4932.8520144395725, 4926.802927882844, 4943.2585112233455, 4966.453690094015, 4969.229769385751, 5005.299258103795, 4993.051320249141, 5026.170681837456, 5036.219385995177, 5040.143175660073, 5082.830948881852, 4849.854504364875, 4880.511948805091, 4904.141775189399, 4934.753262336941, 4946.752662366939, 4951.678140920829, 4962.925556116589, 4977.377827771528, 4982.427020892644, 5010.198368261061, 4898.461169271306, 4909.656324057281, 4939.28380384835, 4945.060438516671, 4951.702897826142, 4792.185328494234, 4909.4845041270155, 4959.70241785494, 4967.03142887148, 5034.119029169954, 4862.489438609036, 4879.512048795092, 4885.389326334208, 4887.0714564232685, 4934.235193545006], "value": 4639.468639834285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2045265484328, 582.653321273842, 596.8328867916982, 597.8968802559276, 598.7425407074959, 27704.584431233547, 40301.39547906784, 41406.0, 41475.377869331984, 45617.0, 39887.40168897461, 40150.7992460038, 40210.59789402105, 40270.0, 40310.59689403105, 7490.775276741707, 7631.313181813635, 7637.618119094023, 7642.617869106551, 7643.961780191091, 7690.961545192295, 7824.530528168328, 7827.608619569027, 7829.021372328459, 7830.138684744674, 7804.0, 7862.135165131831, 7863.724769633064, 7863.960680196619, 7864.724734634289, 7781.844363112735, 7828.608569571498, 7836.059672839296, 7844.725434609818, 7846.607669616496, 7646.847063058708, 7722.613869306569, 7728.188540203254, 7728.6908523658985, 7730.806729831799, 38433.615663843564, 38664.226715465535, 38921.41617875734, 38951.0, 38955.805220974, 2861.4901099997464, 2998.130542142776, 3004.474217012036, 3026.9243268918235, 3084.228942764309, 29922.0, 30191.849040754874, 30834.229144271347, 31078.22304442407, 31125.377492450025, 3369.6124945631323, 3373.713234375081, 3374.5613070300706, 3381.2730262993327, 3410.5054767058637, 249407.0, 249925.0, 250112.99999999817, 250900.0, 251376.99999999817, 46094.76952615215, 47622.76188619104, 54843.45156548463, 55217.723911380184, 55271.44728552663, 57306.696263410995, 58844.705776470844, 58985.41014589799, 64362.356376436575, 64592.0, 14296.499622513162, 14396.42414303437, 14468.782968255484, 14472.276386180649, 14474.203918784568, 9776.462294573867, 11097.44512774358, 11219.831702524469, 11295.49170287339, 11305.095592352756, 16648.583785405463, 17238.310467581407, 17374.39189628357, 17439.825601744073, 17470.47588572345, 6534.014251306699, 6650.0, 6656.077679213564, 6747.561408508432, 6804.8298792529595, 729.4201110117469, 845.2139510255398, 974.8732664753537, 1005.9849102263472, 1016.2530540053203, 27702.5844612331, 27832.304192395353, 28048.158555243375, 28728.13815585536, 28765.712342876723, 900.6667533012827, 936.4989730494153, 956.2780101023683, 1013.9746506337401, 1021.1524434719165, 14652.780208296885, 14727.631809204855, 14788.704225915422, 15030.699386012218, 15082.698346033018, 358772.0, 358927.0, 360805.0, 361016.0, 361593.0, 50235.0, 50465.74767126141, 50585.24122138171, 50646.24030639543, 50740.0, 1055.8152323343384, 1148.4430051425052, 1161.3670549550516, 1174.9412529373326, 1195.9342236177094, 27687.446251074463, 28806.135815925554, 28843.0, 29159.0, 29487.705122948497, 42888.571114289705, 47233.527664724286, 48483.27275090806, 48506.757466212446, 53088.203676944104, 341600.0, 342871.0, 347094.0, 347800.0, 347946.0, 22615.208467703553, 23729.64405533953, 25184.49631007406, 25213.87393063023, 25676.743232568184, 39597.80201098976, 40233.396499053124, 43685.0, 44186.33720494131, 44521.10957780891, 36980.63019369772, 37136.25727485489, 37193.44209836909, 38080.42879356867, 38390.0, 37007.259854802214, 37213.25573488569, 37221.813890930374, 37594.248115037, 37774.811125944194, 36779.26441471209, 36877.44683829691, 37187.25625487529, 37403.2519349606, 37595.2480950374, 31458.842705786323, 33881.66118338884, 33920.491192631634, 33992.66007339895, 34361.82819085888, 25393.238202853943, 25797.613035804854, 25894.223173304832, 26106.347341316618, 26143.044410900347], "value": 17662.644771988285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3139572021717, 361.3585885054029, 365.7183968344373, 373.9439084137379, 376.76452217364147, 15754.684906301882, 16078.839211607881, 16486.75269870953, 17071.146442677862, 17687.204075816586, 15978.520644380658, 16446.83553164468, 16593.502194934143, 16703.83296167038, 16721.581960450996, 4925.187344088221, 5123.743812809364, 5124.820631277906, 5134.64057515974, 5144.639875208737, 3736.4768932349493, 3945.940810887839, 5131.589472842183, 5731.140328950649, 6056.3338032816355, 6081.087836824468, 6089.78685745999, 6102.328743838174, 6110.694465276741, 6110.786122485714, 5806.59353845231, 5949.107633854913, 6034.0948857671265, 6087.847803804918, 6112.358202388752, 3374.1733275347697, 4894.5105489451125, 5102.69383836971, 5165.767540460688, 5197.090509160919, 19984.90007549953, 20821.37535873926, 20824.375268741962, 20881.164753409845, 20884.686729699068, 1743.6599863026715, 1768.6993211154136, 1870.6445775302784, 1993.3421970749619, 2417.7461366556436, 8578.613962371708, 9137.314701397421, 9239.584218710173, 11169.218154729173, 13742.244176570284, 1696.4316953820485, 1714.6742118997352, 1760.2255007796527, 1822.5534743987675, 1827.2234300422401, 72174.63912680403, 72908.0, 73448.6327568364, 73990.26009739887, 74318.62840685816, 9171.082891710908, 9324.0, 9362.297827662953, 9373.906260937303, 9405.247580193569, 12533.0, 12543.623691289276, 12554.183978041397, 12559.058070644556, 12561.937190313989, 7135.286471352823, 7152.320529549685, 7260.96369518149, 7298.890516642255, 7317.853642927112, 6949.687264073129, 6981.301869812978, 6995.26549712283, 7055.682494287769, 7066.470014748915, 3802.144517483544, 3828.5214348206473, 3864.8454061837774, 3905.160390515996, 4276.550962148992, 1535.8233803112562, 1575.7478803391402, 1644.1943447710535, 1652.702513547549, 1667.8248783877762, 746.6229554075265, 757.6931342806172, 794.3367288314207, 885.8793626063035, 950.0689324462066, 16013.59966000836, 16654.916725416297, 16785.24466399015, 17060.146992650567, 17286.0, 822.9094799572042, 852.8464876322197, 852.9914700853036, 896.5830888636684, 937.254882368505, 9062.456252624863, 9259.166674999282, 9337.486438245962, 9595.616175353047, 9629.711108666752, 367552.0, 369677.0, 375778.0, 377627.0, 378817.0, 70996.2900371, 72665.0, 73413.632931835, 73684.0, 74432.0, 909.3634455880909, 946.9905300946903, 957.0955447102422, 959.5154447004358, 959.7168835193635, 15598.610034748768, 15952.0, 16099.678006439572, 16290.67418651644, 16392.262348194123, 27858.0, 33268.0, 33611.83194084014, 34624.13439663928, 37871.621283787914, 49193.50806492032, 49681.75159124326, 51522.22716659178, 51589.0, 52048.219276711636, 6271.184745982993, 6499.5775274607, 6714.764983225564, 6950.339717726808, 7261.3101755333155, 10244.795104097728, 10827.891721083004, 11005.944970275417, 11274.0, 11310.547578096784, 9514.0, 9681.66114186, 9697.369670971646, 9730.75673108178, 10025.649102281384, 9701.757456063655, 9837.9016209837, 9891.703248902544, 9991.200703943812, 10072.647457338959, 5442.183672449164, 6835.794926152024, 9207.802985611828, 9975.750606234611, 10147.086762191439, 6682.665866706742, 6815.318468153145, 6833.214180369321, 6838.384545390939, 6851.314868513308, 9562.808743825224, 9663.661771837951, 9711.708648740549, 9998.400095994264, 10110.949445252727], "value": 7971.099564668087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.8872401483875, 1424.7506686329893, 1443.1052747296674, 1583.2954335320787, 1780.388748182895, 7361.631918404085, 7688.423368247383, 7697.307242348187, 7885.763427097182, 7895.131535531087, 7656.234376562341, 7856.607169641524, 7858.410619203554, 7860.135385107648, 7876.054873415198, 2122.129926730041, 2153.2786516516985, 2154.6983422320886, 2156.5255643758346, 2158.3417057797365, 2163.8593491423085, 2195.034184958621, 2232.7767223277706, 2234.0728597631964, 2235.6311208650554, 2183.1267493002765, 2183.235867446389, 2211.1818627107914, 2214.8228141748623, 2215.523662412589, 2145.1741079684357, 2155.9245426410157, 2163.6754486826944, 2168.4145280774183, 2168.4253672776726, 2120.9045592948355, 2163.7403511578555, 2169.0889826272846, 2169.316665250457, 2172.0551560071262, 7630.236976302381, 7676.232376762335, 7766.184550622216, 7781.844363112706, 7923.524588524707, 4675.812967481296, 4801.615870730333, 4807.086653535852, 4809.807607695723, 4811.206150985084, 2830.1085158175315, 2963.7184467475554, 3025.0924722583136, 3026.4098500792356, 3034.666186719459, 902.1835239108551, 903.6204793986476, 919.967801126964, 927.6660402255183, 928.4011812381044, 10625.681229563126, 10698.983596558392, 10726.731831704192, 10752.247342686014, 10759.62341318058, 4128.690348223835, 4143.357779544175, 4201.054762678434, 4202.978985105116, 4204.726692764961, 8461.11158328379, 8501.14988501145, 8509.702160424355, 8519.403641745143, 8525.57372131391, 4378.0806030733265, 4416.734995900256, 4421.712588681789, 4422.00504886398, 4424.823007079681, 3724.888253352404, 4144.772037537904, 4228.703990720682, 4276.850310239127, 4366.8034938427845, 3419.743519236067, 3441.3633477806684, 3487.9128021799656, 3506.50908872758, 3655.7623754455876, 1043.4886905416292, 1046.8900765419673, 1052.9262951593314, 1056.3767377247461, 1056.6513050693252, 640.9743610255631, 841.835842010802, 844.8859403980507, 859.3297228162044, 865.2342676731013, 4968.72672003036, 4974.477679843637, 4986.476419975923, 5069.5690866276045, 5335.413104558495, 395.24310944540883, 396.69882784466995, 398.67707157202756, 407.5964794853074, 410.86441474313403, 3483.5297234873474, 3551.094470909953, 3577.3918433866306, 3592.7125829933543, 3626.9274614507563, 9384.108509691569, 9725.416475011521, 9745.12293893553, 9748.610055597697, 9751.024897510335, 9429.952850235704, 9499.38254013487, 9503.57233924475, 9567.282453815991, 9673.12941835224, 7347.302006309392, 7389.224131466119, 7406.037215161994, 7425.1832298447125, 7427.331540161412, 4922.507749225048, 4998.375203099613, 5033.043721693013, 5071.822486212965, 5122.948770512247, 8868.379213454997, 8909.440847851729, 8918.0, 9028.954855225682, 9052.818943621223, 9026.45841249527, 9126.908730912606, 9182.632694692405, 9286.442813431217, 9316.860247096163, 6151.753929842756, 6178.227721534809, 6234.220722409699, 6248.843778905563, 6259.029850373199, 7303.525270857377, 7324.523905946096, 7349.081364829396, 7349.853002940018, 7362.4478164136835, 6723.159605049369, 6880.139982502187, 6913.308669133247, 6980.0, 7023.929760702532, 6487.1566696331065, 6504.0, 6635.4359879410795, 6641.701123449359, 6801.047853300641, 6120.663363515049, 6153.876922461436, 6161.691915404302, 6272.466840318624, 6322.652254126067, 4246.363045543193, 4294.227039132986, 4338.739675619473, 4359.912801744011, 4412.713173643703, 4329.415528903558, 4385.364122202199, 4399.824007039811, 4535.591796738309, 4659.697119687209], "value": 4000.8385740696144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.8330568270403, 294.45819691767156, 294.74210066192086, 298.85505529818033, 301.2874551685262, 4635.536446355362, 4753.16819556578, 4759.214729569621, 4804.495527969565, 4804.759762011903, 4684.142672969494, 4708.43498780146, 4730.881727956803, 4771.952280477194, 4775.689580177294, 3479.3389256041273, 3548.1661809474754, 3567.8572857085687, 3707.7382796494117, 3721.274351501458, 3507.5615548056494, 3598.622144674811, 3601.891943241707, 3613.620569840168, 3630.52803135592, 3610.620884807097, 3619.1675914539674, 3626.057225121461, 3633.291508155911, 3650.671439570438, 3627.0413976452683, 3630.6913912317486, 3631.1648320886343, 3644.5079914211506, 3665.87169449068, 3131.6555178930525, 3182.199664295405, 3205.6153261608524, 3215.5980502437196, 3216.7748257621975, 4512.954870451286, 4522.6155776759015, 4525.298578720303, 4530.909381812378, 4547.386102876102, 4109.794510274504, 4122.0, 4152.37714342848, 4152.5432202457705, 4156.459660244179, 4726.409198850144, 4889.168841296988, 4892.263246547495, 4934.679245849008, 4949.78730211097, 3440.2947395784054, 3460.0657822387816, 3466.9826650866585, 3469.444888817802, 3476.5828100628087, 5190.584753219733, 5204.531592156686, 5209.348831396075, 5213.7393130343335, 5220.712860792655, 3554.8222588870453, 3562.839672214757, 3574.5174401455993, 3575.1777091269155, 3596.8598683783107, 3496.265784185299, 3537.8407971641336, 3600.3339382214376, 3605.387084195693, 3660.7254455915913, 4081.6122518343905, 4097.180563887175, 4123.2165888481095, 4123.402106694512, 4127.628513433745, 4916.5004673574185, 4944.975275123601, 4949.0, 4965.82619608312, 4986.202207646832, 1217.701663092548, 1222.394914517302, 1231.2550906701497, 1239.4174737873186, 1242.2670624331688, 784.3685832904453, 791.216695471479, 800.9279164875072, 801.8155824160476, 807.7455601485514, 3902.980485097613, 3976.3696884277306, 4188.790560471964, 4309.332053531708, 4434.401355816988, 5139.9417346678665, 5151.845444636667, 5154.5360917516855, 5154.768035438415, 5157.484251574888, 4380.649548036149, 4406.272964960745, 4408.118376324748, 4420.602145806893, 4422.491413487426, 2592.974070259311, 2681.2358477833723, 2710.7831373490467, 2716.8913243470433, 2723.6050772637855, 4832.275158726219, 4880.755962201947, 4894.877628059256, 4895.437024742129, 4931.284963680247, 5185.740712964337, 5196.8307130896, 5243.348345271227, 5254.2940385701395, 5270.868228294324, 4739.322282910213, 4739.38860787327, 4834.347363105936, 4851.296561998491, 4857.344258525054, 5041.495850414929, 5063.885945092074, 5072.5688316493515, 5110.645678895022, 5141.845744627667, 5011.0, 5038.858485143726, 5039.0, 5044.39467263916, 5052.494750525065, 4623.283391074388, 4845.830395936126, 4848.224284114524, 4861.6596838220985, 4868.513148685103, 3496.59789124254, 3521.1901262710235, 3526.4357702767434, 3531.099569609733, 3546.7339949503375, 5084.8220312288895, 5116.8720781979255, 5117.822900732778, 5138.486151384832, 5138.486151384981, 4770.737609431515, 4969.403671559436, 4985.0, 4998.225275082368, 5006.274090256965, 4977.950220497749, 4996.625253105959, 5000.799968001239, 5001.64988450805, 5010.173321401928, 4923.950760492493, 4946.356973593553, 4946.554810067111, 4949.183384741477, 4975.4278258000795, 4742.596879265163, 4995.775190116381, 5006.6495345325475, 5017.37282839645, 5035.546800787946, 4886.951130488792, 4894.241392584155, 4895.845827835741, 4899.461059283405, 4905.411350637946], "value": 3710.2425484890273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5021855657742, 574.586297865537, 581.4127730991697, 664.5372467193416, 668.8395633575745, 9760.85358719618, 11519.596814111508, 12210.572629957953, 12355.50577976881, 12359.258444493336, 12270.509179632827, 12733.61799146027, 12800.167989080703, 12806.67983300418, 12813.615591532245, 626.4549841637781, 780.4575819805237, 787.3740376400775, 788.3023524181084, 790.8339248757768, 787.7991112266365, 792.9841403171934, 793.817421992942, 793.9245771651683, 794.9602519874012, 834.2241715204888, 835.1690068381938, 839.2488722593275, 839.5172775653992, 839.7690635075342, 825.8637324841394, 826.7189155687096, 829.4981536170591, 831.0526000359534, 831.9792005199857, 608.2913405882142, 610.8778244351103, 615.4153554123601, 615.4922189193933, 615.5506480269383, 11584.0, 11679.0, 11684.47419866108, 11686.24039437434, 11729.0, 11937.0, 12188.756224875453, 12408.0, 12536.623901282976, 12548.1216314858, 10118.340240675103, 10158.238132140119, 10257.43584102874, 10409.0, 10664.946675266652, 3304.8182349970743, 3324.2188085800058, 3353.782004169721, 3383.5601371821754, 3453.3438646657055, 48575.514244857804, 48740.0, 49064.0, 50421.49578504205, 50851.23723144119, 9600.615975360908, 9943.045563549276, 10114.494275286354, 10146.797064058677, 10227.590896364061, 17279.827201728072, 17319.65360692779, 17328.133593320283, 17338.0, 17363.392281270095, 6596.406323430819, 6731.124953755981, 6784.3554862288, 6935.583864968118, 7070.646467676595, 3497.405441075023, 3542.8009867033147, 3556.91107722309, 3575.284943011408, 3611.8870460780736, 2907.5057240269207, 3020.8036477628884, 3022.45595792755, 3025.9546106808416, 3026.5914101596004, 497.6541303793829, 501.7591556053115, 506.0360014173006, 515.4330236739556, 521.5514657394638, 480.219643079995, 500.33752928563297, 548.1749966300772, 583.291301069203, 586.8767558812697, 7527.305961614235, 7584.658690358947, 7695.422843286776, 7717.498362606412, 7759.844803104019, 519.5687579309164, 555.5056000159781, 578.563333797243, 589.0251633546487, 596.2546816479401, 3518.7360947928496, 3528.400171970771, 3558.839852206657, 3666.3400587894434, 3673.412254039341, 58405.415945839995, 58864.41135588675, 60800.69599651973, 60843.695781521696, 60940.39059609436, 52968.90857551354, 53030.204546931825, 53989.3139815383, 54153.0, 54159.0, 49090.50909490931, 49214.0, 49642.50357496379, 49996.0, 50033.49966500361, 7426.554406735613, 7481.1732065001115, 7665.88501172494, 7715.691372345043, 7866.528008319519, 29739.851300743358, 29875.701242987292, 30150.54774178345, 30722.846385767927, 31175.220619484695, 39543.40684889672, 39854.2029159421, 39913.600863990985, 39973.40039899462, 41194.58805412027, 10137.543810528692, 10770.299930504492, 10849.240553161519, 10853.186011049045, 11050.889491104987, 10375.169986400919, 10698.0, 11379.829302560303, 11871.584494542649, 12103.394830258629, 10859.674209773719, 10919.071878890383, 10935.890641093805, 10959.835602466128, 10982.780344393228, 10051.949740251252, 10196.4391958443, 10605.840912386166, 10824.729381765204, 11159.27464714791, 10791.514381852678, 11199.88800112021, 11202.04782593456, 11233.0, 11382.829257561309, 8955.507447090473, 9081.636734530544, 9115.225205857576, 9277.814443711222, 9369.390989585656, 8731.519766412654, 8920.197182253629, 9105.135012173832, 9148.496832674267, 9359.906400936175], "value": 5909.1355737410095, "unit": "score"}], "name": "dromaeo_css", "value": 6209.099201189251, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 131.0, 141.0, 183.0, 139.0, 162.0, 155.0, 134.0, 206.0, 133.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 163.0, 160.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 121.0, 77.0, 76.0, 75.0, 75.0, 99.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 84.0, 84.0, 83.0, 123.0, 85.0, 85.0, 133.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 84.0, 91.0, 85.0, 86.0, 89.0, 87.0, 84.0, 139.0, 91.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 129.0, 129.0, 128.0, 128.0, 134.0, 130.0, 146.0, 133.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 170.0, 170.0, 171.0, 172.0, 169.0, 173.0, 171.0, 174.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 70.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1560.4, "alertThreshold": 2.0}]} 04:30:35 INFO - Return code: 0 04:30:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:30:35 ERROR - # TBPL SUCCESS # 04:30:35 INFO - Running post-action listener: _resource_record_post_action 04:30:35 INFO - ##### 04:30:35 INFO - ##### Finished run-tests step (success) 04:30:35 INFO - ##### 04:30:35 INFO - Running post-run listener: _resource_record_post_run 04:30:35 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522465280; Read time: 12; Write time: 416676 04:30:35 INFO - TinderboxPrint: CPU usage
13.1% 04:30:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:30:35 INFO - TinderboxPrint: I/O write bytes / time
522,465,280 / 416,676 04:30:35 INFO - TinderboxPrint: CPU idle
8,316.7 (86.9%) 04:30:35 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 04:30:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236982272; Read time: 0; Write time: 241816 04:30:35 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285405184; Read time: 12; Write time: 174860 04:30:35 INFO - Running post-run listener: _upload_blobber_files 04:30:35 INFO - Blob upload gear active. 04:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:35 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 04:30:35 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:35 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:40 INFO - (blobuploader) - INFO - Done attempting. 04:30:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:30:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:41 INFO - (blobuploader) - INFO - Done attempting. 04:30:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:30:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:41 INFO - (blobuploader) - INFO - Done attempting. 04:30:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:41 INFO - Return code: 0 04:30:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a74df162d3a8598f100852f478dbe9c23769b28152e7f5fef51fe93da83b927ad83635874c02285e9d1460ee23c936d5c1482cda741faef3e48212ede3b56b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a64b8e2758b5520f177e624a4afab868944c51b89dfce187678ed6f319310758738b5d94ec387864c6a3d3d8b5fbff625c9b9b5d2c484fca3f9e0687ae5d1cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98065fb493ab234327d09c9791b5c7a54c4ec0133f02e25e4b0ba337639d9095a23cab5e79e2c17cecc44d6189fff99c1e13d6cf9aab17e9babc60e2a5457dbe"} 04:30:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:41 INFO - Contents: 04:30:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a74df162d3a8598f100852f478dbe9c23769b28152e7f5fef51fe93da83b927ad83635874c02285e9d1460ee23c936d5c1482cda741faef3e48212ede3b56b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a64b8e2758b5520f177e624a4afab868944c51b89dfce187678ed6f319310758738b5d94ec387864c6a3d3d8b5fbff625c9b9b5d2c484fca3f9e0687ae5d1cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98065fb493ab234327d09c9791b5c7a54c4ec0133f02e25e4b0ba337639d9095a23cab5e79e2c17cecc44d6189fff99c1e13d6cf9aab17e9babc60e2a5457dbe"} 04:30:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:41 INFO - Copying logs to upload dir... 04:30:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.997161 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-31 04:30:39.962077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 04:30:39.966230) ========= 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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a74df162d3a8598f100852f478dbe9c23769b28152e7f5fef51fe93da83b927ad83635874c02285e9d1460ee23c936d5c1482cda741faef3e48212ede3b56b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a64b8e2758b5520f177e624a4afab868944c51b89dfce187678ed6f319310758738b5d94ec387864c6a3d3d8b5fbff625c9b9b5d2c484fca3f9e0687ae5d1cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98065fb493ab234327d09c9791b5c7a54c4ec0133f02e25e4b0ba337639d9095a23cab5e79e2c17cecc44d6189fff99c1e13d6cf9aab17e9babc60e2a5457dbe"} build_url:https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/ZdobVe6TTLqTeElRKvJmaQ/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/Firefox-Non-PGO/sha512/e2a74df162d3a8598f100852f478dbe9c23769b28152e7f5fef51fe93da83b927ad83635874c02285e9d1460ee23c936d5c1482cda741faef3e48212ede3b56b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a64b8e2758b5520f177e624a4afab868944c51b89dfce187678ed6f319310758738b5d94ec387864c6a3d3d8b5fbff625c9b9b5d2c484fca3f9e0687ae5d1cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98065fb493ab234327d09c9791b5c7a54c4ec0133f02e25e4b0ba337639d9095a23cab5e79e2c17cecc44d6189fff99c1e13d6cf9aab17e9babc60e2a5457dbe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 04:30:39.992166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:30:39.992503) ========= 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=523ca41ca1e0623de333ad52000001bf-1464688599.586523-1557933666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 04:30:40.074658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 04:30:40.074982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 04:30:40.075274) ========= ========= Total master_lag: 0.15 =========