builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1462971697.56 results: success (0) buildid: 20160511023007 builduid: 1c14df4b706649ad96711d1d155471c3 revision: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.564175) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.564647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.564915) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.577879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.578157) ========= 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=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 06:01:37-- 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% 223M=0s 2016-05-11 06:01:37 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.664307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.664641) ========= 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=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:37.714166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 06:01:37.714536) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 --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=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 06:01:37,777 truncating revision to first 12 chars 2016-05-11 06:01:37,777 Setting DEBUG logging. 2016-05-11 06:01:37,777 attempt 1/10 2016-05-11 06:01:37,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/52f40a1102ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 06:01:39,023 unpacking tar archive at: fx-team-52f40a1102ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 06:01:39.301249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:39.301585) ========= script_repo_revision: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:39.301967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:39.302226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:01:39.311068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 06:01:39.311449) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:39 INFO - MultiFileLogger online at 20160511 06:01:39 in /builds/slave/test 06:01:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:01:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:39 INFO - {'append_to_log': False, 06:01:39 INFO - 'base_work_dir': '/builds/slave/test', 06:01:39 INFO - 'blob_upload_branch': 'Fx-Team', 06:01:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:39 INFO - 'branch': 'Fx-Team', 06:01:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:39 INFO - 'config_files': ('talos/linux_config.py',), 06:01:39 INFO - 'default_actions': ('clobber', 06:01:39 INFO - 'read-buildbot-config', 06:01:39 INFO - 'download-and-extract', 06:01:39 INFO - 'populate-webroot', 06:01:39 INFO - 'create-virtualenv', 06:01:39 INFO - 'install', 06:01:39 INFO - 'run-tests'), 06:01:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:39 INFO - 'download_minidump_stackwalk': True, 06:01:39 INFO - 'download_symbols': 'ondemand', 06:01:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:39 INFO - 'installer_path': 'installer.exe', 06:01:39 INFO - 'log_level': 'info', 06:01:39 INFO - 'log_name': 'talos', 06:01:39 INFO - 'log_to_console': True, 06:01:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:39 INFO - 'opt_config_files': (), 06:01:39 INFO - 'pip_index': False, 06:01:39 INFO - 'sps_profile': False, 06:01:39 INFO - 'sps_profile_interval': 0, 06:01:39 INFO - 'suite': 'dromaeojs', 06:01:39 INFO - 'system_bits': '32', 06:01:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:39 INFO - 'title': 'talos-linux64-ix-026', 06:01:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:39 INFO - 'use_talos_json': True, 06:01:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:39 INFO - 'work_dir': 'build'} 06:01:39 INFO - ##### 06:01:39 INFO - ##### Running clobber step. 06:01:39 INFO - ##### 06:01:39 INFO - Running pre-action listener: _resource_record_pre_action 06:01:39 INFO - Running main action method: clobber 06:01:39 INFO - rmtree: /builds/slave/test/build 06:01:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:39 INFO - Running post-action listener: _resource_record_post_action 06:01:39 INFO - ##### 06:01:39 INFO - ##### Finished clobber step (success) 06:01:39 INFO - ##### 06:01:39 INFO - ##### 06:01:39 INFO - ##### Running read-buildbot-config step. 06:01:39 INFO - ##### 06:01:39 INFO - Running pre-action listener: _resource_record_pre_action 06:01:39 INFO - Running main action method: read_buildbot_config 06:01:39 INFO - Using buildbot properties: 06:01:39 INFO - { 06:01:39 INFO - "project": "", 06:01:39 INFO - "product": "firefox", 06:01:39 INFO - "script_repo_revision": "production", 06:01:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:01:39 INFO - "repository": "", 06:01:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:01:39 INFO - "buildid": "20160511023007", 06:01:39 INFO - "pgo_build": "True", 06:01:39 INFO - "basedir": "/builds/slave/test", 06:01:39 INFO - "buildnumber": 663, 06:01:39 INFO - "slavename": "talos-linux64-ix-026", 06:01:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:01:39 INFO - "platform": "ubuntu64_hw", 06:01:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:01:39 INFO - "branch": "fx-team", 06:01:39 INFO - "repo_path": "integration/fx-team", 06:01:39 INFO - "revision": "52f40a1102ad7c5bf8f463334b37595ecbc5bd73", 06:01:39 INFO - "stage_platform": "linux64-pgo", 06:01:39 INFO - "builduid": "1c14df4b706649ad96711d1d155471c3", 06:01:39 INFO - "slavebuilddir": "test" 06:01:39 INFO - } 06:01:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:01:39 INFO - Running post-action listener: _resource_record_post_action 06:01:39 INFO - ##### 06:01:39 INFO - ##### Finished read-buildbot-config step (success) 06:01:39 INFO - ##### 06:01:39 INFO - ##### 06:01:39 INFO - ##### Running download-and-extract step. 06:01:39 INFO - ##### 06:01:39 INFO - Running pre-action listener: _resource_record_pre_action 06:01:39 INFO - Running main action method: download_and_extract 06:01:39 INFO - mkdir: /builds/slave/test/build/tests 06:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:39 INFO - https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:40 INFO - Downloaded 1361 bytes. 06:01:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:01:40 INFO - Using the following test package requirements: 06:01:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:01:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'jsshell-linux-x86_64.zip'], 06:01:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:40 INFO - https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:41 INFO - Downloaded 23903081 bytes. 06:01:41 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'] 06:01:41 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 06:01:42 INFO - Return code: 0 06:01:42 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 06:01:42 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')]} 06:01:42 INFO - https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:44 INFO - Downloaded 23903081 bytes. 06:01:44 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'] 06:01:44 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 06:01:45 INFO - Return code: 0 06:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:45 INFO - https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:01:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:46 INFO - Downloaded 10840152 bytes. 06:01:46 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'] 06:01:46 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 06:01:46 INFO - Return code: 0 06:01:46 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')]} 06:01:46 INFO - https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIrobmLnT2yDINrPwj330g/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 06:01:49 INFO - Downloaded 58336325 bytes. 06:01:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:01:49 INFO - mkdir: /builds/slave/test/properties 06:01:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:01:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:01:49 INFO - Contents: 06:01:49 INFO - build_url:https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:01:49 INFO - Running post-action listener: _resource_record_post_action 06:01:49 INFO - Running post-action listener: set_extra_try_arguments 06:01:49 INFO - ##### 06:01:49 INFO - ##### Finished download-and-extract step (success) 06:01:49 INFO - ##### 06:01:49 INFO - ##### 06:01:49 INFO - ##### Running populate-webroot step. 06:01:49 INFO - ##### 06:01:49 INFO - Running pre-action listener: _resource_record_pre_action 06:01:49 INFO - Running main action method: populate_webroot 06:01:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:49 INFO - '--tppagecycles', 06:01:49 INFO - '7'], 06:01:49 INFO - 'tests': ['tsvgm']}}, 06:01:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:01:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:01:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:01:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['damp', 'tps']}, 06:01:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'tests': ['damp', 'tps']}, 06:01:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['dromaeo_dom']}, 06:01:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['a11yr', 06:01:49 INFO - 'ts_paint', 06:01:49 INFO - 'tpaint', 06:01:49 INFO - 'sessionrestore', 06:01:49 INFO - 'sessionrestore_no_auto_restore', 06:01:49 INFO - 'tabpaint']}, 06:01:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['tsvgx', 06:01:49 INFO - 'tsvgr_opacity', 06:01:49 INFO - 'tart', 06:01:49 INFO - 'tscrollx', 06:01:49 INFO - 'cart']}, 06:01:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:01:49 INFO - 'tsvgr_opacity', 06:01:49 INFO - 'tart', 06:01:49 INFO - 'tscrollx', 06:01:49 INFO - 'cart']}, 06:01:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'talos_options': ['--disable-e10s'], 06:01:49 INFO - 'tests': ['tp5o']}, 06:01:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'tests': ['tp5o']}, 06:01:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'talos_options': ['--disable-e10s', 06:01:49 INFO - '--xperf_path', 06:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:49 INFO - 'tests': ['tp5n']}, 06:01:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:49 INFO - 'talos_options': ['--xperf_path', 06:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:49 INFO - 'tests': ['tp5n']}}, 06:01:49 INFO - 'talos.zip': {'path': '', 06:01:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:49 INFO - Running post-action listener: _resource_record_post_action 06:01:49 INFO - ##### 06:01:49 INFO - ##### Finished populate-webroot step (success) 06:01:49 INFO - ##### 06:01:49 INFO - ##### 06:01:49 INFO - ##### Running create-virtualenv step. 06:01:49 INFO - ##### 06:01:49 INFO - Running pre-action listener: _resource_record_pre_action 06:01:49 INFO - Running main action method: create_virtualenv 06:01:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:01:49 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 06:01:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:01:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:49 INFO - Using real prefix '/usr' 06:01:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:52 INFO - Installing pip.................done. 06:01:52 INFO - Return code: 0 06:01:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:52 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 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:01:52 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 06:01:52 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 06:01:52 INFO - Using env: {'DISPLAY': ':0', 06:01:52 INFO - 'HOME': '/home/cltbld', 06:01:52 INFO - 'LANG': 'en_US.UTF-8', 06:01:52 INFO - 'LANGUAGE': 'en_US:en', 06:01:52 INFO - 'LOGNAME': 'cltbld', 06:01:52 INFO - 'MAIL': '/var/mail/cltbld', 06:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:52 INFO - 'MOZ_NO_REMOTE': '1', 06:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:52 INFO - 'NO_EM_RESTART': '1', 06:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:52 INFO - 'PWD': '/builds/slave/test', 06:01:52 INFO - 'SHELL': '/bin/bash', 06:01:52 INFO - 'SHLVL': '1', 06:01:52 INFO - 'TERM': 'linux', 06:01:52 INFO - 'TMOUT': '86400', 06:01:52 INFO - 'USER': 'cltbld', 06:01:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:52 INFO - '_': '/tools/buildbot/bin/python'} 06:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:52 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 06:01:52 INFO - Cleaning up... 06:01:52 INFO - Return code: 0 06:01:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:52 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:01:52 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>=0.7.1'] in /builds/slave/test/build 06:01:52 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>=0.7.1 06:01:52 INFO - Using env: {'DISPLAY': ':0', 06:01:52 INFO - 'HOME': '/home/cltbld', 06:01:52 INFO - 'LANG': 'en_US.UTF-8', 06:01:52 INFO - 'LANGUAGE': 'en_US:en', 06:01:52 INFO - 'LOGNAME': 'cltbld', 06:01:52 INFO - 'MAIL': '/var/mail/cltbld', 06:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:52 INFO - 'MOZ_NO_REMOTE': '1', 06:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:52 INFO - 'NO_EM_RESTART': '1', 06:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:52 INFO - 'PWD': '/builds/slave/test', 06:01:52 INFO - 'SHELL': '/bin/bash', 06:01:52 INFO - 'SHLVL': '1', 06:01:52 INFO - 'TERM': 'linux', 06:01:52 INFO - 'TMOUT': '86400', 06:01:52 INFO - 'USER': 'cltbld', 06:01:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:52 INFO - '_': '/tools/buildbot/bin/python'} 06:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:52 INFO - Downloading/unpacking psutil>=0.7.1 06:01:52 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 06:01:52 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 06:01:52 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 06:01:52 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 06:01:52 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 06:01:52 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 06:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:54 INFO - Installing collected packages: psutil 06:01:54 INFO - Running setup.py install for psutil 06:01:54 INFO - building 'psutil._psutil_linux' extension 06:01:54 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 06:01:54 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 06:01:55 INFO - building 'psutil._psutil_posix' extension 06:01:55 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 06:01:55 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 06:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:55 INFO - Successfully installed psutil 06:01:55 INFO - Cleaning up... 06:01:55 INFO - Return code: 0 06:01:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:01:55 INFO - Using env: {'DISPLAY': ':0', 06:01:55 INFO - 'HOME': '/home/cltbld', 06:01:55 INFO - 'LANG': 'en_US.UTF-8', 06:01:55 INFO - 'LANGUAGE': 'en_US:en', 06:01:55 INFO - 'LOGNAME': 'cltbld', 06:01:55 INFO - 'MAIL': '/var/mail/cltbld', 06:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:55 INFO - 'MOZ_NO_REMOTE': '1', 06:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:55 INFO - 'NO_EM_RESTART': '1', 06:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:55 INFO - 'PWD': '/builds/slave/test', 06:01:55 INFO - 'SHELL': '/bin/bash', 06:01:55 INFO - 'SHLVL': '1', 06:01:55 INFO - 'TERM': 'linux', 06:01:55 INFO - 'TMOUT': '86400', 06:01:55 INFO - 'USER': 'cltbld', 06:01:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:55 INFO - '_': '/tools/buildbot/bin/python'} 06:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:01:57 INFO - Installing collected packages: mozsystemmonitor 06:01:57 INFO - Running setup.py install for mozsystemmonitor 06:01:57 INFO - Successfully installed mozsystemmonitor 06:01:57 INFO - Cleaning up... 06:01:57 INFO - Return code: 0 06:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:01:57 INFO - Using env: {'DISPLAY': ':0', 06:01:57 INFO - 'HOME': '/home/cltbld', 06:01:57 INFO - 'LANG': 'en_US.UTF-8', 06:01:57 INFO - 'LANGUAGE': 'en_US:en', 06:01:57 INFO - 'LOGNAME': 'cltbld', 06:01:57 INFO - 'MAIL': '/var/mail/cltbld', 06:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:57 INFO - 'MOZ_NO_REMOTE': '1', 06:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:57 INFO - 'NO_EM_RESTART': '1', 06:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:57 INFO - 'PWD': '/builds/slave/test', 06:01:57 INFO - 'SHELL': '/bin/bash', 06:01:57 INFO - 'SHLVL': '1', 06:01:57 INFO - 'TERM': 'linux', 06:01:57 INFO - 'TMOUT': '86400', 06:01:57 INFO - 'USER': 'cltbld', 06:01:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:57 INFO - '_': '/tools/buildbot/bin/python'} 06:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:59 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 06:01:59 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 06:01:59 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 06:01:59 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 06:01:59 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 06:01:59 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 06:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:00 INFO - Downloading docopt-0.6.1.tar.gz 06:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:00 INFO - Running setup.py install for blobuploader 06:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:00 INFO - Running setup.py install for requests 06:02:00 INFO - Running setup.py install for docopt 06:02:00 INFO - Successfully installed blobuploader requests docopt 06:02:00 INFO - Cleaning up... 06:02:01 INFO - Return code: 0 06:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:01 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 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:02:01 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 06:02:01 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 06:02:01 INFO - Using env: {'DISPLAY': ':0', 06:02:01 INFO - 'HOME': '/home/cltbld', 06:02:01 INFO - 'LANG': 'en_US.UTF-8', 06:02:01 INFO - 'LANGUAGE': 'en_US:en', 06:02:01 INFO - 'LOGNAME': 'cltbld', 06:02:01 INFO - 'MAIL': '/var/mail/cltbld', 06:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:01 INFO - 'MOZ_NO_REMOTE': '1', 06:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:01 INFO - 'NO_EM_RESTART': '1', 06:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:01 INFO - 'PWD': '/builds/slave/test', 06:02:01 INFO - 'SHELL': '/bin/bash', 06:02:01 INFO - 'SHLVL': '1', 06:02:01 INFO - 'TERM': 'linux', 06:02:01 INFO - 'TMOUT': '86400', 06:02:01 INFO - 'USER': 'cltbld', 06:02:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:01 INFO - '_': '/tools/buildbot/bin/python'} 06:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:01 INFO - Running setup.py (path:/tmp/pip-_HMi3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:01 INFO - Running setup.py (path:/tmp/pip-KZ0kYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:01 INFO - Running setup.py (path:/tmp/pip-0F6n9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:01 INFO - Running setup.py (path:/tmp/pip-5Tlu8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:01 INFO - Running setup.py (path:/tmp/pip-QYgMEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:01 INFO - Running setup.py (path:/tmp/pip-Cm_FZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:01 INFO - Running setup.py (path:/tmp/pip-hgWZ1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:01 INFO - Running setup.py (path:/tmp/pip-Eao7M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:01 INFO - Running setup.py (path:/tmp/pip-NgBf_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:01 INFO - Running setup.py (path:/tmp/pip-L4lsWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:01 INFO - Running setup.py (path:/tmp/pip-otn_28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:02 INFO - Running setup.py (path:/tmp/pip-7t2Uwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:02 INFO - Running setup.py (path:/tmp/pip-dmuZWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:02 INFO - Running setup.py (path:/tmp/pip-ZzlO4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:02 INFO - Running setup.py (path:/tmp/pip-FdrsJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:02 INFO - Running setup.py (path:/tmp/pip-3n2XRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:02 INFO - Running setup.py (path:/tmp/pip-lRJAz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:02 INFO - Running setup.py install for manifestparser 06:02:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:02 INFO - Running setup.py install for mozcrash 06:02:02 INFO - Running setup.py install for mozdebug 06:02:02 INFO - Running setup.py install for mozdevice 06:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:02 INFO - Running setup.py install for mozfile 06:02:02 INFO - Running setup.py install for mozhttpd 06:02:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozinfo 06:02:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozInstall 06:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozleak 06:02:03 INFO - Running setup.py install for mozlog 06:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for moznetwork 06:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozprocess 06:02:03 INFO - Running setup.py install for mozprofile 06:02:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozrunner 06:02:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:03 INFO - Running setup.py install for mozscreenshot 06:02:04 INFO - Running setup.py install for moztest 06:02:04 INFO - Running setup.py install for mozversion 06:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:04 INFO - Cleaning up... 06:02:04 INFO - Return code: 0 06:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:04 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')]} 06:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:04 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')]} 06:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:04 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 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:02:04 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 06:02:04 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 06:02:04 INFO - Using env: {'DISPLAY': ':0', 06:02:04 INFO - 'HOME': '/home/cltbld', 06:02:04 INFO - 'LANG': 'en_US.UTF-8', 06:02:04 INFO - 'LANGUAGE': 'en_US:en', 06:02:04 INFO - 'LOGNAME': 'cltbld', 06:02:04 INFO - 'MAIL': '/var/mail/cltbld', 06:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:04 INFO - 'MOZ_NO_REMOTE': '1', 06:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:04 INFO - 'NO_EM_RESTART': '1', 06:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:04 INFO - 'PWD': '/builds/slave/test', 06:02:04 INFO - 'SHELL': '/bin/bash', 06:02:04 INFO - 'SHLVL': '1', 06:02:04 INFO - 'TERM': 'linux', 06:02:04 INFO - 'TMOUT': '86400', 06:02:04 INFO - 'USER': 'cltbld', 06:02:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:04 INFO - '_': '/tools/buildbot/bin/python'} 06:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:04 INFO - Running setup.py (path:/tmp/pip-6la5ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:04 INFO - Running setup.py (path:/tmp/pip-O5haY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:04 INFO - Running setup.py (path:/tmp/pip-V4N7ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:04 INFO - Running setup.py (path:/tmp/pip-zLibev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:04 INFO - Running setup.py (path:/tmp/pip-piG__3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:04 INFO - Running setup.py (path:/tmp/pip-t_3tyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:04 INFO - Running setup.py (path:/tmp/pip-eNg6PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:04 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)) 06:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:04 INFO - Running setup.py (path:/tmp/pip-gfWa_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:05 INFO - Running setup.py (path:/tmp/pip-BY9m_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:05 INFO - Running setup.py (path:/tmp/pip-XdFm_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:05 INFO - Running setup.py (path:/tmp/pip-28ncZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:05 INFO - Running setup.py (path:/tmp/pip-djru6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:05 INFO - Running setup.py (path:/tmp/pip-O_eGbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:05 INFO - Running setup.py (path:/tmp/pip-eBLZy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:05 INFO - Running setup.py (path:/tmp/pip-zpvGcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:05 INFO - Running setup.py (path:/tmp/pip-XJ5N0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:05 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)) 06:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:05 INFO - Running setup.py (path:/tmp/pip-qV91ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:05 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)) 06:02:05 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)) 06:02:05 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)) 06:02:05 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)) 06:02:05 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)) 06:02:05 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)) 06:02:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:05 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 06:02:05 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 06:02:05 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 06:02:05 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 06:02:05 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 06:02:05 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 06:02:07 INFO - Downloading blessings-1.6.tar.gz 06:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:07 INFO - Installing collected packages: blessings 06:02:07 INFO - Running setup.py install for blessings 06:02:07 INFO - Successfully installed blessings 06:02:07 INFO - Cleaning up... 06:02:07 INFO - Return code: 0 06:02:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:07 INFO - Reading from file tmpfile_stdout 06:02:07 INFO - Current package versions: 06:02:07 INFO - argparse == 1.2.1 06:02:07 INFO - blessings == 1.6 06:02:07 INFO - blobuploader == 1.2.4 06:02:07 INFO - docopt == 0.6.1 06:02:07 INFO - manifestparser == 1.1 06:02:07 INFO - mozInstall == 1.12 06:02:07 INFO - mozcrash == 0.17 06:02:07 INFO - mozdebug == 0.1 06:02:07 INFO - mozdevice == 0.48 06:02:07 INFO - mozfile == 1.2 06:02:07 INFO - mozhttpd == 0.7 06:02:07 INFO - mozinfo == 0.9 06:02:07 INFO - mozleak == 0.1 06:02:07 INFO - mozlog == 3.1 06:02:07 INFO - moznetwork == 0.27 06:02:07 INFO - mozprocess == 0.22 06:02:07 INFO - mozprofile == 0.28 06:02:07 INFO - mozrunner == 6.11 06:02:07 INFO - mozscreenshot == 0.1 06:02:07 INFO - mozsystemmonitor == 0.0 06:02:07 INFO - moztest == 0.7 06:02:07 INFO - mozversion == 1.4 06:02:07 INFO - psutil == 3.1.1 06:02:07 INFO - requests == 1.2.3 06:02:07 INFO - wsgiref == 0.1.2 06:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:07 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 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:02:07 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 06:02:07 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 06:02:07 INFO - Using env: {'DISPLAY': ':0', 06:02:07 INFO - 'HOME': '/home/cltbld', 06:02:07 INFO - 'LANG': 'en_US.UTF-8', 06:02:07 INFO - 'LANGUAGE': 'en_US:en', 06:02:07 INFO - 'LOGNAME': 'cltbld', 06:02:07 INFO - 'MAIL': '/var/mail/cltbld', 06:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:07 INFO - 'MOZ_NO_REMOTE': '1', 06:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:07 INFO - 'NO_EM_RESTART': '1', 06:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:07 INFO - 'PWD': '/builds/slave/test', 06:02:07 INFO - 'SHELL': '/bin/bash', 06:02:07 INFO - 'SHLVL': '1', 06:02:07 INFO - 'TERM': 'linux', 06:02:07 INFO - 'TMOUT': '86400', 06:02:07 INFO - 'USER': 'cltbld', 06:02:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:07 INFO - '_': '/tools/buildbot/bin/python'} 06:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 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)) 06:02:08 INFO - Cleaning up... 06:02:08 INFO - Return code: 0 06:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:02:08 INFO - Using env: {'DISPLAY': ':0', 06:02:08 INFO - 'HOME': '/home/cltbld', 06:02:08 INFO - 'LANG': 'en_US.UTF-8', 06:02:08 INFO - 'LANGUAGE': 'en_US:en', 06:02:08 INFO - 'LOGNAME': 'cltbld', 06:02:08 INFO - 'MAIL': '/var/mail/cltbld', 06:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:08 INFO - 'MOZ_NO_REMOTE': '1', 06:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:08 INFO - 'NO_EM_RESTART': '1', 06:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:08 INFO - 'PWD': '/builds/slave/test', 06:02:08 INFO - 'SHELL': '/bin/bash', 06:02:08 INFO - 'SHLVL': '1', 06:02:08 INFO - 'TERM': 'linux', 06:02:08 INFO - 'TMOUT': '86400', 06:02:08 INFO - 'USER': 'cltbld', 06:02:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:08 INFO - '_': '/tools/buildbot/bin/python'} 06:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:08 INFO - Downloading/unpacking jsonschema 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:10 INFO - Downloading/unpacking functools32 (from jsonschema) 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:10 INFO - warning: no files found matching '*.txt' 06:02:10 INFO - no previously-included directories found matching 'build' 06:02:10 INFO - no previously-included directories found matching 'dist' 06:02:10 INFO - no previously-included directories found matching '.git*' 06:02:10 INFO - Installing collected packages: jsonschema, functools32 06:02:10 INFO - Running setup.py install for functools32 06:02:10 INFO - warning: no files found matching '*.txt' 06:02:10 INFO - no previously-included directories found matching 'build' 06:02:10 INFO - no previously-included directories found matching 'dist' 06:02:10 INFO - no previously-included directories found matching '.git*' 06:02:10 INFO - Successfully installed jsonschema functools32 06:02:10 INFO - Cleaning up... 06:02:10 INFO - Return code: 0 06:02:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc2dbebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe45770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, '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': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', '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 06:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:02:10 INFO - Using env: {'DISPLAY': ':0', 06:02:10 INFO - 'HOME': '/home/cltbld', 06:02:10 INFO - 'LANG': 'en_US.UTF-8', 06:02:10 INFO - 'LANGUAGE': 'en_US:en', 06:02:10 INFO - 'LOGNAME': 'cltbld', 06:02:10 INFO - 'MAIL': '/var/mail/cltbld', 06:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:10 INFO - 'MOZ_NO_REMOTE': '1', 06:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:10 INFO - 'NO_EM_RESTART': '1', 06:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:10 INFO - 'PWD': '/builds/slave/test', 06:02:10 INFO - 'SHELL': '/bin/bash', 06:02:10 INFO - 'SHLVL': '1', 06:02:10 INFO - 'TERM': 'linux', 06:02:10 INFO - 'TMOUT': '86400', 06:02:10 INFO - 'USER': 'cltbld', 06:02:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:10 INFO - '_': '/tools/buildbot/bin/python'} 06:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:10 INFO - Downloading/unpacking flake8 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:02:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:02:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:13 INFO - no previously-included directories found matching 'docs/_build' 06:02:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:02:13 INFO - Running setup.py install for pep8 06:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:13 INFO - no previously-included directories found matching 'docs/_build' 06:02:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:02:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:02:13 INFO - Cleaning up... 06:02:13 INFO - Return code: 0 06:02:13 INFO - Running post-action listener: _resource_record_post_action 06:02:13 INFO - Running post-action listener: _start_resource_monitoring 06:02:13 INFO - Starting resource monitoring. 06:02:13 INFO - ##### 06:02:13 INFO - ##### Finished create-virtualenv step (success) 06:02:13 INFO - ##### 06:02:13 INFO - ##### 06:02:13 INFO - ##### Running install step. 06:02:13 INFO - ##### 06:02:13 INFO - Running pre-action listener: _resource_record_pre_action 06:02:13 INFO - Running main action method: install 06:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:14 INFO - Reading from file tmpfile_stdout 06:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:14 INFO - Reading from file tmpfile_stdout 06:02:14 INFO - Output received: 06:02:14 INFO - Usage: mozinstall [options] installer 06:02:14 INFO - Options: 06:02:14 INFO - -h, --help show this help message and exit 06:02:14 INFO - -d DEST, --destination=DEST 06:02:14 INFO - Directory to install application into. [default: 06:02:14 INFO - "/builds/slave/test"] 06:02:14 INFO - --app=APP Application being installed. [default: firefox] 06:02:14 INFO - mkdir: /builds/slave/test/build/application 06:02:14 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'] 06:02:14 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 06:02:30 INFO - Reading from file tmpfile_stdout 06:02:30 INFO - Output received: 06:02:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:30 INFO - Running post-action listener: _resource_record_post_action 06:02:30 INFO - ##### 06:02:30 INFO - ##### Finished install step (success) 06:02:30 INFO - ##### 06:02:30 INFO - ##### 06:02:30 INFO - ##### Running run-tests step. 06:02:30 INFO - ##### 06:02:30 INFO - Running pre-action listener: _resource_record_pre_action 06:02:30 INFO - Running main action method: run_tests 06:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:30 INFO - Python 2.7.3 06:02:30 INFO - Return code: 0 06:02:30 INFO - grabbing minidump binary from tooltool 06:02: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')]} 06:02:30 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 0xed49c0>, '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 0xed58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:30 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 06:02:30 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 06:02:30 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 06:02:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:30 INFO - Return code: 0 06:02:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:02:31 INFO - Return code: 0 06:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 06:02:31 INFO - Using env: {'DISPLAY': ':0', 06:02:31 INFO - 'HOME': '/home/cltbld', 06:02:31 INFO - 'LANG': 'en_US.UTF-8', 06:02:31 INFO - 'LANGUAGE': 'en_US:en', 06:02:31 INFO - 'LOGNAME': 'cltbld', 06:02:31 INFO - 'MAIL': '/var/mail/cltbld', 06:02:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:31 INFO - 'MOZ_NO_REMOTE': '1', 06:02:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:31 INFO - 'NO_EM_RESTART': '1', 06:02:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:31 INFO - 'PWD': '/builds/slave/test', 06:02:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:31 INFO - 'SHELL': '/bin/bash', 06:02:31 INFO - 'SHLVL': '1', 06:02:31 INFO - 'TERM': 'linux', 06:02:31 INFO - 'TMOUT': '86400', 06:02:31 INFO - 'USER': 'cltbld', 06:02:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585', 06:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:31 INFO - '_': '/tools/buildbot/bin/python'} 06:02:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:02:31 INFO - mozversion application_buildid: 20160511023007 06:02:31 INFO - mozversion application_changeset: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 06:02:31 INFO - mozversion application_display_name: Nightly 06:02:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:31 INFO - mozversion application_name: Firefox 06:02:31 INFO - mozversion application_remotingname: firefox 06:02:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:02:31 INFO - mozversion application_vendor: Mozilla 06:02:31 INFO - mozversion application_version: 49.0a1 06:02:31 INFO - mozversion platform_buildid: 20160511023007 06:02:31 INFO - mozversion platform_changeset: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 06:02:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:02:31 INFO - mozversion platform_version: 49.0a1 06:02:31 INFO - using testdate: 1462971751 06:02:31 INFO - actual date: 1462971751 06:02:31 INFO - starting webserver on 'localhost:37779' 06:02:31 INFO - SUITE-START | Running 2 tests 06:02:31 INFO - TEST-START | dromaeo_css 06:02:31 INFO - operating with platform_type : linux_ 06:02:31 INFO - Initialising browser for dromaeo_css test... 06:02:31 INFO - TEST-INFO | started process 13478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2nEWrD/profile http://localhost:37779/getInfo.html) 06:02:35 INFO - PROCESS | 13478 | __metrics Screen width/height:1600/1200 06:02:35 INFO - PROCESS | 13478 | colorDepth:24 06:02:35 INFO - PROCESS | 13478 | Browser inner width/height: 1024/697 06:02:35 INFO - PROCESS | 13478 | __metrics 06:02:36 ERROR - PROCESS | 13478 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:02:37 INFO - TEST-INFO | 13478: exit 0 06:02:37 INFO - Browser initialized. 06:02:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:37 INFO - TEST-INFO | started process 13563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2nEWrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:49 INFO - PROCESS | 13563 | RSS: Main: 151699456 06:02:49 INFO - PROCESS | 13563 | 06:03:40 INFO - PROCESS | 13563 | 1462971820594 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] 06:05:48 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37779/tests/dromaeo/cssquery-ext.html) 06:05:49 INFO - PROCESS | 13563 | RSS: Main: 243003392 06:05:49 INFO - PROCESS | 13563 | 06:08:51 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-ext.html (next: http://localhost:37779/tests/dromaeo/cssquery-jquery.html) 06:08:52 INFO - PROCESS | 13563 | RSS: Main: 241680384 06:08:52 INFO - PROCESS | 13563 | 06:11:54 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37779/tests/dromaeo/cssquery-mootools.html) 06:11:54 INFO - PROCESS | 13563 | RSS: Main: 251953152 06:11:54 INFO - PROCESS | 13563 | 06:14:56 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37779/tests/dromaeo/cssquery-prototype.html) 06:14:57 INFO - PROCESS | 13563 | RSS: Main: 241848320 06:14:57 INFO - PROCESS | 13563 | 06:18:00 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37779/tests/dromaeo/cssquery-yui.html) 06:18:00 INFO - PROCESS | 13563 | RSS: Main: 230969344 06:18:00 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:37779/tests/dromaeo/cssquery-yui.html (next: http://localhost:37779/tests/dromaeo/cssquery-dojo.html) 06:21:03 INFO - PROCESS | 13563 | RSS: Main: 278708224 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | __start_tp_report 06:21:03 INFO - PROCESS | 13563 | _x_x_mozilla_page_load 06:21:03 INFO - PROCESS | 13563 | _x_x_mozilla_page_load_details 06:21:03 INFO - PROCESS | 13563 | |i|pagename|runs| 06:21:03 INFO - PROCESS | 13563 | |0;dojo.html;3161.873525058996;3196.0252123102455;3198.200449887528;3225.6451790303063;3228.354329134174;5287.709175995319;5320.654157479771;5349.170878513832;5430.72846357682;5458.4541545845395;5292.497212764791;5314.627976041678;5342.038433082053;5437.891242175154;5469.808556700516;4711.411073615789;4741.502142275063;4955.157623204064;4992.950070499303;5039.496050394968;4937.77779999899;4962.131626965267;4972.154733695281;4991.875203119933;4996.800127994876;4688.906221875561;4740.028294199698;4775.21209000518;4819;4832.879178020543;4841.709497430165;4842.4189097308545;4851.733154676492;4907.4356449008465;4913.115639184945;4813.422389313269;4843.055604157191;4851.902961940777;4864.610831133501;4894.951050489485;5194.532492075731;5287.365516138049;5291.3385826771655;5350.759215835296;5355.544778693816;5705.172749951275;5723.599348045638;5749.367569567345;5781.739821708034;5829.387914269026;5833.38749431312;5842.649441033509;5848.619839710448;5858.648481091105;5922.496587790043;5286.07493688603;5390.380106287748;5393.919091213635;5402.594805389612;5417.674939503642;5944.286685597756;5991.700414979234;5996.580239383288;6015.037593985029;6018;5503.834884953458;5735.627184233012;5738.024535828919;5767.625104368202;5794.101914203306;5681.715914204273;5720.056190728483;5724.885502290014;5754.136879468029;5759.136129580513;5705.857353566111;5715.742791574389;5717.485426311652;5721.828345149652;5724.542036637059;5498.917516237259;5677.120046392815;5725.971370143206;5734.741936612862;5737.627054241461;4309.784510774449;4333.046729719456;4336.6530677545725;4373.234683930299;4375.409319741858;3899.668528175137;3903.965449155976;3918.3338832398563;3927.430522574268;3953.6639385652543;5338.733063346895;5392.865178370494;5412.107002344648;5475.151351540518;5518.061929471999;5686.545076393879;5774.797882074107;5789.334226563915;5794.0439827428845;5796.710164491843;5407.621466497386;5416;5421.566274698014;5425.023495770799;5477.096279113981;4793.18515852299;4914.410270767531;4956.677815941952;4958.057968985881;4962.949341735824;5967.522598192134;5985.670788106609;5990.580659353804;5994.070919007474;5997.310309314485;5750.7987220447085;5758.856028599151;5799.4780469757925;5802.216700745515;5804.82585522435;5803.709814509342;5946.494547963472;5989.221401217814;5999.70001499932;6098.0852872069545;5758.942410575841;5760.452756988079;5767.769289228384;5774.538036956949;5786.797462088806;5827.213326201078;5843.649381037151;5898.469137777621;5898.9705051476185;5904.202932604044;5486.862828429162;5592.524635406036;5609.859753506195;5623.831285061455;5679.5172410345585;5658.236138121301;5658.434156584309;5662.065759149694;5664.0371136906;5676.489115979582;5401.729913504388;5578.386377498391;5591.664500130005;5593.524550413098;5593.9440605595055;5671.291088613923;5695.544356451557;5705.201271822031;5785.479306862402;5793.797217097382;5622.437756224344;5627.465390787868;5629;5637.802676906289;5674.092145256739 06:21:03 INFO - PROCESS | 13563 | |1;ext.html;631.2078341681191;648.1412128929167;656.0683828962872;659.5976454362841;663.3234101216759;43962.12075758487;45700;45723.77138114309;48944.021119577585;49063.50936490634;45837.77081114598;46159;46273.768631156796;46308.536914630844;46344.304835427494;8816;8967.686130985418;8970.147835955573;8972.371933964625;8974.46153230805;8858.645654173857;8926.152015558544;8940.016598174196;8943.195112439878;8947.597358118901;8910.465372077664;8950.507722075283;8967.730968070935;8973.506457144855;8974.102589741005;8884.466931984069;8919.331050171264;8919.331050171264;8925.642974281021;8925.999999999967;8818.86771698425;8910.777230569223;8917.866232006525;8925.285977121815;8929.06244844295;43040.13919721588;43196.3520547192;43264.78367608173;43387.13225735499;43452.78273608643;3451.361498122855;3660.267946410702;4077.429159917614;4286.185624731291;4378.824847006116;33700.32599348024;34150.658493414994;34865.47701784475;36459;36465.088372790626;4365.759883206422;4441.089576636814;4481.193385190664;4516.683832131752;4628.773375055613;339861;343594;343622;343706;343788;53904;59441.70279148577;61644.691776541724;62039.37960620336;62774.37225627685;64112;64321;64409.35590644128;64499.35500644933;64749.67625161844;16080.919595401949;16086.919565402332;16118.75821862673;16144.67710645804;16147;12724.681882953;12906.870931290567;13351.132176408502;13380.19718816874;13383.799243011363;19387.806121938884;19476.51308717265;19796.60406791856;20342.694859577117;20533.897330513253;7033.402160816286;7186.532875363085;7394.334509894135;7460.962695186489;7473.551586904803;1005.1305620638095;1013.2096964367805;1022.8374046370528;1112.783007313566;1133.8072527670315;33126.8343658285;33180.33639327248;33681.49477757836;33698.32603347919;34379.82810085933;1145.5495400369623;1145.6391236760394;1224.1981502116128;1252.1047451072527;1298.214580178997;17667.911660441616;17961.461156165336;18018.2792688291;18056.90971545134;18103.366382176824;519926;522825;524927;525015;527005;59870.70064649649;60275.095873561055;60340.698296508235;60407.69796150991;60427;1393.3103113958655;1415.1084816565499;1439.3810661415691;1448.8116544849313;1452.194032312056;30986.845065774527;31105.68894311028;31411.685883140875;32305.51541726829;33138.337233254715;51969.740151299;52100.21849672182;52343;52441.7377913108;52531.73734131305;412414;416821;419410;420696;420965;25645.743542564334;27128;27475.587866181624;28255.858720706266;28280.717192827808;48669.2699609499;48865.26702099542;49064.509354906;49473.55790863074;49635.25547116868;41297.1740565193;41687.791561042;42548.78725606476;42669.35995960001;42810.57189428191;41565.79217103895;41715.7914210427;42516;42911;46215.76892115518;42525.57474425216;43389.783051084545;43792.562074378846;43931.560684392745;44015;36005.81997090102;37694.8115259422;38025.429618555194;38216;38591.0798238852;28253.71746282511;28468.85765571159;28541.857290713415;28757.28106797347;29058.564121538617 06:21:03 INFO - PROCESS | 13563 | |2;jquery.html;394.52459785957916;403.2318433384403;403.90104424416023;410.2492438836929;421.83759252687724;13294.800577991338;18883.20609542093;19713.310034148806;19728.408147755556;19765.50586235345;14531.91010674201;18403.26386944524;18714.71927921079;18895.33866314679;19802.801971980276;5711.942880571203;5897;5909.379515150912;5925.377835327293;5951.761929522814;5857.004309267435;5861.589688721791;5879.0593505039205;5889.705514724268;5907.852303692399;4261.2329780639475;4399.9660079881205;5456.454354564532;6466.708998095097;6475.320091390383;6453.257875344349;6516.5112616553715;6577.868442631145;6581.341865813428;6586.407223349897;5612.214289999403;5686.2607860977805;5696.715164241813;5737.598368114233;5738.82783516491;22905.88547057254;23036.884815575984;23153.53692926132;23641.172558960352;23881.283561493183;2364.606789257421;2552.719200887901;2557.360659835041;2592.896284148632;2593.753593408623;13687.452501899912;14436.711265774626;14500.057496262814;14558.272086395638;15259.923700381538;1949.580840119381;2004.6692295771181;2030.9743579492263;2049.3237231713497;2071.730675012239;75641;79062.20937790607;79338.60330698367;79746.60126699446;79773;10440.321379110486;10720.624778132727;10771.246012779187;11180.09938310489;11213.943930280297;15208.315625796866;15332.846671533365;15342.539723808304;15356.155411452253;15361.926139970961;8629.093945135795;8649.610767515476;8711.520866352284;8799.560021999003;8842.77893052666;8710.041895391501;8719.171678690514;8731.519766412908;8747.387682862138;8893.644254229888;5951.464368206882;6143.539234557426;6674.2658307586125;6744.840291781791;6791;1793.1213705284317;1797.8022417534062;1803.801581825998;1809.4842969753556;1854.063697832613;939.3655040229951;985.6993616946756;1012.9161796877271;1023.3194925374543;1100.4620146229909;18849.340273090376;19435.708464373045;20152.798472015387;20273.08771105304;20409.795902041085;1048.6434612231878;1075.7955988362187;1082.8429877667695;1095.9178061645248;1149.1840793037038;11019.779604408028;11497.482613282422;11568.710782230342;11591;11596.768064638829;454428;459458;463852;466607;466809;79778.20221797824;81584;81866;82196.58901705572;82732.17267827365;1037.4812593703148;1057.8413238014205;1061.8938106189319;1063.3726101600093;1072.0940805019902;16435.342586296414;17905.910470447565;17923.28306867711;17927.193276302336;17970;37723.622763773106;40671.98320041904;41003.58996410117;41410.79500663567;43115.7844210777;50821.74589127031;52317.47682523126;55585.722071389384;55827;56049;7206.135263768172;7511.173770885089;7889.13219545838;8821.161989610977;9059.094090590888;9239.445633261757;12861.164024338388;13434.93282533581;13546.390412431267;13961.860381396462;6417.197850268716;10722.177229870784;10897.455127243447;12231.877681223074;12466.439010244741;12357.93821030889;12425.93787031059;12581.559645412366;12698.30159341245;12829.358532073173;12314.876851231731;12443.626691199279;12503.687407814878;12720.87279127197;12919.741605167656;8836.867446988428;9072.319576031692;9134.634614615341;9148.222401095982;9211.124943130391;10425.582976680847;12147.21043132229;12151.331676757509;12160.635180944586;12401.441935113122 06:21:03 INFO - PROCESS | 13563 | |3;mootools.html;1381.6476798416402;1515.0606623893188;1536.0092740182579;1674.2884274183477;1839.3562253211387;7668.309852113309;8559.144085591446;8729.388942774009;8819.470831750099;9068.682596109138;8758.518281494515;8910.821783564325;8915.286777057836;8942.418742781714;8951.641934322635;2065.070718176819;2259.5029093599383;2325.023490134148;2372.9288121356344;2399.520095980802;2373.3354660694945;2389.569877422063;2391.234804862445;2391.4141035446255;2393.282015395383;2338.240071976606;2384.940376490584;2386.1052105460453;2386.2364043506086;2391.6651668766385;2047.8771273723623;2301.1945818963313;2348.7181538215355;2357.0807385119815;2369.3484291819714;2240.8991595378084;2246.056656204398;2246.786555277246;2251.0658076898067;2313.548857972696;8849.823003539957;8961.551922403918;8967.372283940127;8979.371443998923;8990;5152.175651895679;5288.762005709752;5293.232481290192;5299.4435584263865;5303.124984377573;3307;3357.5635167428077;3398.9660103398896;3461.463473161664;3480.8085555294447;1090.569225156059;1097.7310558913039;1130.0168853097775;1132.898039176478;1143.3540049871879;12102.031837452983;12105.15263931525;12109.39453027354;12115.030797536176;12134.817977730341;4653.837115700934;4691.53084691535;4758.976205118952;4777.498362671939;4798.904021919612;10246.53890574926;10258.487075646337;10261.589536418609;10270.845937310796;10286.485675716185;4851.733154676456;5263.289455923478;5280.894382112413;5284;5289.629725919149;4734.905301893943;4873.878153046131;4889.364382630307;4909.484504127086;4921.9507804922205;4005.048380311294;4025.7383270087353;4061.1877624474632;4069.4302797608357;4070.6539944105084;1269.504893091695;1275.7576060548465;1276.7574160909398;1291.464042422403;1292.3925754895183;891.790429249126;920.9539523023822;953.9666111686058;1003.4731765823001;1058.9841152382721;6155.230596175478;6256.092866534418;6259.874802504016;6351.809445716636;6475.32009139043;472.0865125981237;475.0593824228048;479.0825569035328;483.77262686537273;483.9008003359303;4283.678724095706;4355.1289742051085;4423.137488189772;4459.554044595515;4521.88695282614;10688.839667404995;10939.726506837234;11165.776684466266;11176.27354221973;11182.16133789969;10428.374297542172;10971.39657318839;11010.559577616967;11086.501107450184;11102;8026.077001144943;8227.382946279053;8345.082040975487;8348.499090054616;8445.746627601182;6244.344343843831;6390.52071094679;6486.416222539994;6498.610083394822;6554.737810487718;10159.492025398848;10448.2163837714;10465.581376744845;10645.467726613793;10701.304415212986;10400.531976060944;10531.210159237935;10635.14918806478;10691.518881650189;10801.621943231949;7112.964435177791;7586.9620651898595;7875.054993400829;7948.046234451903;8084;8725.563721813756;8736.03903570594;8771.342149338698;8802.07578204305;8809.383343165917;7733.149353570991;7822.256885595859;7834.059912810271;7972.880406793786;8041.517508949481;7399.149097853816;7667.808304792202;7725.884111738441;7864.882026769717;7873;7010.298970102949;7177.892331615134;7269.818254543678;7278.599677017814;7289.088863892013;5349.839504814861;5378.381486128988;5476.17857321405;5478.233047373451;5593.804216852391;5527.336719593674;5530.834074977757;5546.195801608664;5635.971820141037;5687.146927960839 06:21:03 INFO - PROCESS | 13563 | |4;prototype.html;320.6825243009421;329.28545057225824;341.3667646515713;348.67747333716306;351.63078767294337;5290.656107353019;5295.152775555912;5306.416294207634;5350.411454739976;5375.623706340558;5265.131253343204;5285.048691235576;5285.180796976475;5311.282976798131;5325.600579956499;3764.454154147647;3901.687864970803;3921.5294264650756;4021.899452513696;4028;4035.233305671913;4079.5104587449546;4086.5913408659194;4092.85675001375;4100.118474527976;4019.919601607966;4039.030632648158;4047.8178481968234;4052.7365721228175;4067.776272305022;3896.5713771485116;3923.8038098095267;4048.210598933209;4052.675785937118;4070.470838790938;3604.891853244407;3638.199596088856;3638.6725194732603;3647.544056992876;3660.396034654279;5029.949700503022;5040.59675225981;5060.898782024339;5063.746812659389;5074.797008119671;4435.3125265583885;4689.531046895318;4696.553827386393;4702.952970470285;4736.857894263143;5485.945140548583;5513.61404701671;5515.420880807497;5520.309961254843;5530.944690553083;3941.310270702644;3959.6238357356006;3985.9800700996598;3995.5604883462797;4003.3594624860175;5565.749541270652;5806.361300256968;5810.796622118206;5819.563532735019;5821.767129314865;3951.150502641888;3999.2601368746873;4019.21625283067;4035.858744943913;4046.4537287466405;4031.9193616127513;4119.0937993641355;4158.91682166361;4170.22850772608;4171.0823618803815;4618.676692631483;4709.7174169549935;4720.740359280273;4731.172044892199;4752.95247047532;5629;5632.493075623213;5632.577556683265;5637.43625637433;5638.323401191883;1394.958151255464;1410.7601707709714;1412.1174266083697;1416.5396246219814;1417.9929100354432;840.3949156607233;877.6313948141795;915.7134226411902;920.8305452075826;931.3713243560569;4714.175019371665;4751.239801631791;4774.188387974053;4777.546133117348;4787.640926930494;4992.825251116194;5062.063518249062;5065.822696205615;5081.8729531762;5086.491350864958;4587.38070360497;4791.586481987822;4810.206315957827;4822.421309442819;4824.903501929942;2701.5812549054926;2707.7563019327963;2712.850793206353;2717.3070866928806;2717.3750037491486;5210.557102646242;5216.817411390583;5218.086834803894;5237.454950789526;5259.36887573486;4936.75316234194;5090.414602320707;5130.307408499804;5157.6647517911215;5579.553635709133;5764.423557644286;5941.376155503696;5951.345352011275;5965.777015711768;5972.432618901197;5627.606067575231;5635.971820140873;5738.741756620879;5759.596828221985;5810.273715785527;5307.65500242483;5589.580781441489;5590.720463976866;5617.32592088952;5642.85892852682;5821.301443826768;5839.970800145972;5848.590598658053;5848.853778655397;5879.823605291848;4045.474088368493;4073.185362927367;4081.1633615109427;4098.569650186688;4122.56713045126;5514.779408823602;5649.152627105803;5671.517920976763;5684.71576421169;5714.3999880012;5492.928878868583;5508.586855985737;5515.558755299647;5558.305211848519;5649.576281778801;5303.761330740203;5511.448855114457;5529.944700552943;5578.721063946705;5620.859478512906;5481.698506582176;5483.396826349178;5494.532964698045;5498.615096943336;5499.615026948075;5486.0923710433535;5531.834044978657;5571.526420254324;5574.108142697149;5645.661260324394;5305.814296499604;5413.188021796762;5449.64577302474;5467.043267428264;5490.231367608618 06:21:03 INFO - PROCESS | 13563 | |5;yui.html;803.1767438375664;841.4993079117927;843.1905370843989;874.724461794535;878.7715194049549;14657.340419681113;15036.323365448554;15241.847581524182;15259.16074615897;15282.235888205601;13509.189448633064;13573.52492662757;13579.52471663492;13580.660483487918;13587.524436644719;689.5965859971898;814.5642081486405;816.302061737215;830.6013113705425;850.8213275212213;824.1017291152642;829.4276948905236;830.0537387378394;832.0847068224934;832.4381042796089;887.5340446265698;890.1899271662788;894.065701342099;894.6868595991416;894.8523493623577;734.3024127079296;845.8773477845708;876.8816209811721;878.8945326560789;887.0951629338072;636;636.045931103345;636.2396935661886;636.3318515558691;636.7262077306756;14256.35846386915;14271.928640356731;14280.143191408548;14287.357068931922;14299.213543255117;13770.518031868936;14129.78805317921;14185.645358866008;14203.218822964733;14243.643908902257;12190.268583884996;12220.694482637917;12311.138220324581;12532.99736021116;12550.497980080785;4496.280595104768;4533.659975501851;4533.727976321398;4534.501204867462;4537.160625284333;53532.197017044775;53740.46259537394;54413.72793136049;54450.455495445334;54460.45539544593;11091.389973551532;11149.609763658233;11265.605703800327;11321;11371.147163962736;19737.703934440993;19757.308494202633;19800;19846;19847.404577862686;7915.287624113857;7922.128565857866;7977.122516523178;8294.875576866352;8359;4549.431321084864;4668.953310466852;4844.224924012141;4900.485449027872;5039.571636410873;3336.833158342122;3363.764536482423;3406.5401170842115;3429.4341433663167;3436.9656303437146;671.5601281160848;716.8494269660202;718.7161071376881;726.0234983946583;729.3472342253654;747.6075060593123;769.2730369800597;786.3119770201074;794.3327604811985;802.5265093594807;10058;10282.434466104436;10407.94796026015;10412.219083568763;10519.263651544472;722.7073035420663;724.6449239872425;742.1354122447397;743.141671369569;755.9546427214385;4643.326717625925;4654.604358629486;4676.275177347517;4761.809527618926;4807.110684523374;64985.35014649793;65906.34093659098;66008.66995664992;67417.32582674209;67717;56184.15723764147;57854.42145578575;58211.70894145502;58554.707226464445;60437.69781151066;51218.48781512212;52361.7381913088;52433.47566524362;53229.46770532322;54374;9239.815203695754;9467.289953253396;9478.431294122374;9508.096730810563;9511.476868772284;34654;35171.29657406889;35415.645843541235;35573;35926.28147437089;44993;46345;46735.76632116818;47341.08236470441;49115.26327105168;11753.353565553634;11929.880701192877;12020.879791202326;12070.456829442872;12264.509419623471;10805.567777288821;13063.477460901457;13227.470901163846;13656.590302290948;13797.24115173675;13208.735825283633;13264.336783160996;13266.933665331997;13785.448582057006;14203.857961420666;12978.286194259406;13107.14803537767;13271.734565308447;13392;14021.3690383935;12727.172733772275;12992.220466772023;13263.602091937257;13361.331933403097;13406.061575689608;10751.462426878468;11014.339139651647;11286.266392684449;11433.59982400612;11557;10912.290701104403;10947.56209751601;10972.780544389227;11010.39442830652;11097.445127743418 06:21:03 INFO - PROCESS | 13563 | __end_tp_report 06:21:03 INFO - PROCESS | 13563 | __start_cc_report 06:21:03 INFO - PROCESS | 13563 | _x_x_mozilla_cycle_collect,794 06:21:03 INFO - PROCESS | 13563 | __end_cc_report 06:21:03 INFO - PROCESS | 13563 | __startTimestamp1462972863696__endTimestamp 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | ------- Summary: start ------- 06:21:03 INFO - PROCESS | 13563 | Number of tests: 6 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#0] dojo.html Cycles:165 Average:5357.15 Median:5593.52 stddev:617.68 (11.0%) stddev-sans-first:595.08 06:21:03 INFO - PROCESS | 13563 | Values: 3161.9 3196.0 3198.2 3225.6 3228.4 5287.7 5320.7 5349.2 5430.7 5458.5 5292.5 5314.6 5342.0 5437.9 5469.8 4711.4 4741.5 4955.2 4993.0 5039.5 4937.8 4962.1 4972.2 4991.9 4996.8 4688.9 4740.0 4775.2 4819.0 4832.9 4841.7 4842.4 4851.7 4907.4 4913.1 4813.4 4843.1 4851.9 4864.6 4895.0 5194.5 5287.4 5291.3 5350.8 5355.5 5705.2 5723.6 5749.4 5781.7 5829.4 5833.4 5842.6 5848.6 5858.6 5922.5 5286.1 5390.4 5393.9 5402.6 5417.7 5944.3 5991.7 5996.6 6015.0 6018.0 5503.8 5735.6 5738.0 5767.6 5794.1 5681.7 5720.1 5724.9 5754.1 5759.1 5705.9 5715.7 5717.5 5721.8 5724.5 5498.9 5677.1 5726.0 5734.7 5737.6 4309.8 4333.0 4336.7 4373.2 4375.4 3899.7 3904.0 3918.3 3927.4 3953.7 5338.7 5392.9 5412.1 5475.2 5518.1 5686.5 5774.8 5789.3 5794.0 5796.7 5407.6 5416.0 5421.6 5425.0 5477.1 4793.2 4914.4 4956.7 4958.1 4962.9 5967.5 5985.7 5990.6 5994.1 5997.3 5750.8 5758.9 5799.5 5802.2 5804.8 5803.7 5946.5 5989.2 5999.7 6098.1 5758.9 5760.5 5767.8 5774.5 5786.8 5827.2 5843.6 5898.5 5899.0 5904.2 5486.9 5592.5 5609.9 5623.8 5679.5 5658.2 5658.4 5662.1 5664.0 5676.5 5401.7 5578.4 5591.7 5593.5 5593.9 5671.3 5695.5 5705.2 5785.5 5793.8 5622.4 5627.5 5629.0 5637.8 5674.1 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#1] ext.html Cycles:180 Average:60053.49 Median:43230.57 stddev:114984.59 (266.0%) stddev-sans-first:115220.59 06:21:03 INFO - PROCESS | 13563 | Values: 631.2 648.1 656.1 659.6 663.3 43962.1 45700.0 45723.8 48944.0 49063.5 45837.8 46159.0 46273.8 46308.5 46344.3 8816.0 8967.7 8970.1 8972.4 8974.5 8858.6 8926.2 8940.0 8943.2 8947.6 8910.5 8950.5 8967.7 8973.5 8974.1 8884.5 8919.3 8919.3 8925.6 8926.0 8818.9 8910.8 8917.9 8925.3 8929.1 43040.1 43196.4 43264.8 43387.1 43452.8 3451.4 3660.3 4077.4 4286.2 4378.8 33700.3 34150.7 34865.5 36459.0 36465.1 4365.8 4441.1 4481.2 4516.7 4628.8 339861.0 343594.0 343622.0 343706.0 343788.0 53904.0 59441.7 61644.7 62039.4 62774.4 64112.0 64321.0 64409.4 64499.4 64749.7 16080.9 16086.9 16118.8 16144.7 16147.0 12724.7 12906.9 13351.1 13380.2 13383.8 19387.8 19476.5 19796.6 20342.7 20533.9 7033.4 7186.5 7394.3 7461.0 7473.6 1005.1 1013.2 1022.8 1112.8 1133.8 33126.8 33180.3 33681.5 33698.3 34379.8 1145.5 1145.6 1224.2 1252.1 1298.2 17667.9 17961.5 18018.3 18056.9 18103.4 519926.0 522825.0 524927.0 525015.0 527005.0 59870.7 60275.1 60340.7 60407.7 60427.0 1393.3 1415.1 1439.4 1448.8 1452.2 30986.8 31105.7 31411.7 32305.5 33138.3 51969.7 52100.2 52343.0 52441.7 52531.7 412414.0 416821.0 419410.0 420696.0 420965.0 25645.7 27128.0 27475.6 28255.9 28280.7 48669.3 48865.3 49064.5 49473.6 49635.3 41297.2 41687.8 42548.8 42669.4 42810.6 41565.8 41715.8 42516.0 42911.0 46215.8 42525.6 43389.8 43792.6 43931.6 44015.0 36005.8 37694.8 38025.4 38216.0 38591.1 28253.7 28468.9 28541.9 28757.3 29058.6 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#2] jquery.html Cycles:180 Average:27982.62 Median:23761.23 stddev:76010.41 (319.9%) stddev-sans-first:76195.42 06:21:03 INFO - PROCESS | 13563 | Values: 394.5 403.2 403.9 410.2 421.8 13294.8 18883.2 19713.3 19728.4 19765.5 14531.9 18403.3 18714.7 18895.3 19802.8 5711.9 5897.0 5909.4 5925.4 5951.8 5857.0 5861.6 5879.1 5889.7 5907.9 4261.2 4400.0 5456.5 6466.7 6475.3 6453.3 6516.5 6577.9 6581.3 6586.4 5612.2 5686.3 5696.7 5737.6 5738.8 22905.9 23036.9 23153.5 23641.2 23881.3 2364.6 2552.7 2557.4 2592.9 2593.8 13687.5 14436.7 14500.1 14558.3 15259.9 1949.6 2004.7 2031.0 2049.3 2071.7 75641.0 79062.2 79338.6 79746.6 79773.0 10440.3 10720.6 10771.2 11180.1 11213.9 15208.3 15332.8 15342.5 15356.2 15361.9 8629.1 8649.6 8711.5 8799.6 8842.8 8710.0 8719.2 8731.5 8747.4 8893.6 5951.5 6143.5 6674.3 6744.8 6791.0 1793.1 1797.8 1803.8 1809.5 1854.1 939.4 985.7 1012.9 1023.3 1100.5 18849.3 19435.7 20152.8 20273.1 20409.8 1048.6 1075.8 1082.8 1095.9 1149.2 11019.8 11497.5 11568.7 11591.0 11596.8 454428.0 459458.0 463852.0 466607.0 466809.0 79778.2 81584.0 81866.0 82196.6 82732.2 1037.5 1057.8 1061.9 1063.4 1072.1 16435.3 17905.9 17923.3 17927.2 17970.0 37723.6 40672.0 41003.6 41410.8 43115.8 50821.7 52317.5 55585.7 55827.0 56049.0 7206.1 7511.2 7889.1 8821.2 9059.1 9239.4 12861.2 13434.9 13546.4 13961.9 6417.2 10722.2 10897.5 12231.9 12466.4 12357.9 12425.9 12581.6 12698.3 12829.4 12314.9 12443.6 12503.7 12720.9 12919.7 8836.9 9072.3 9134.6 9148.2 9211.1 10425.6 12147.2 12151.3 12160.6 12401.4 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#3] mootools.html Cycles:180 Average:5892.30 Median:2604.98 stddev:3347.78 (128.5%) stddev-sans-first:3340.01 06:21:03 INFO - PROCESS | 13563 | Values: 1381.6 1515.1 1536.0 1674.3 1839.4 7668.3 8559.1 8729.4 8819.5 9068.7 8758.5 8910.8 8915.3 8942.4 8951.6 2065.1 2259.5 2325.0 2372.9 2399.5 2373.3 2389.6 2391.2 2391.4 2393.3 2338.2 2384.9 2386.1 2386.2 2391.7 2047.9 2301.2 2348.7 2357.1 2369.3 2240.9 2246.1 2246.8 2251.1 2313.5 8849.8 8961.6 8967.4 8979.4 8990.0 5152.2 5288.8 5293.2 5299.4 5303.1 3307.0 3357.6 3399.0 3461.5 3480.8 1090.6 1097.7 1130.0 1132.9 1143.4 12102.0 12105.2 12109.4 12115.0 12134.8 4653.8 4691.5 4759.0 4777.5 4798.9 10246.5 10258.5 10261.6 10270.8 10286.5 4851.7 5263.3 5280.9 5284.0 5289.6 4734.9 4873.9 4889.4 4909.5 4922.0 4005.0 4025.7 4061.2 4069.4 4070.7 1269.5 1275.8 1276.8 1291.5 1292.4 891.8 921.0 954.0 1003.5 1059.0 6155.2 6256.1 6259.9 6351.8 6475.3 472.1 475.1 479.1 483.8 483.9 4283.7 4355.1 4423.1 4459.6 4521.9 10688.8 10939.7 11165.8 11176.3 11182.2 10428.4 10971.4 11010.6 11086.5 11102.0 8026.1 8227.4 8345.1 8348.5 8445.7 6244.3 6390.5 6486.4 6498.6 6554.7 10159.5 10448.2 10465.6 10645.5 10701.3 10400.5 10531.2 10635.1 10691.5 10801.6 7113.0 7587.0 7875.1 7948.0 8084.0 8725.6 8736.0 8771.3 8802.1 8809.4 7733.1 7822.3 7834.1 7972.9 8041.5 7399.1 7667.8 7725.9 7864.9 7873.0 7010.3 7177.9 7269.8 7278.6 7289.1 5349.8 5378.4 5476.2 5478.2 5593.8 5527.3 5530.8 5546.2 5636.0 5687.1 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#4] prototype.html Cycles:180 Average:4566.51 Median:5088.45 stddev:1351.68 (26.6%) stddev-sans-first:1317.37 06:21:03 INFO - PROCESS | 13563 | Values: 320.7 329.3 341.4 348.7 351.6 5290.7 5295.2 5306.4 5350.4 5375.6 5265.1 5285.0 5285.2 5311.3 5325.6 3764.5 3901.7 3921.5 4021.9 4028.0 4035.2 4079.5 4086.6 4092.9 4100.1 4019.9 4039.0 4047.8 4052.7 4067.8 3896.6 3923.8 4048.2 4052.7 4070.5 3604.9 3638.2 3638.7 3647.5 3660.4 5029.9 5040.6 5060.9 5063.7 5074.8 4435.3 4689.5 4696.6 4703.0 4736.9 5485.9 5513.6 5515.4 5520.3 5530.9 3941.3 3959.6 3986.0 3995.6 4003.4 5565.7 5806.4 5810.8 5819.6 5821.8 3951.2 3999.3 4019.2 4035.9 4046.5 4031.9 4119.1 4158.9 4170.2 4171.1 4618.7 4709.7 4720.7 4731.2 4753.0 5629.0 5632.5 5632.6 5637.4 5638.3 1395.0 1410.8 1412.1 1416.5 1418.0 840.4 877.6 915.7 920.8 931.4 4714.2 4751.2 4774.2 4777.5 4787.6 4992.8 5062.1 5065.8 5081.9 5086.5 4587.4 4791.6 4810.2 4822.4 4824.9 2701.6 2707.8 2712.9 2717.3 2717.4 5210.6 5216.8 5218.1 5237.5 5259.4 4936.8 5090.4 5130.3 5157.7 5579.6 5764.4 5941.4 5951.3 5965.8 5972.4 5627.6 5636.0 5738.7 5759.6 5810.3 5307.7 5589.6 5590.7 5617.3 5642.9 5821.3 5840.0 5848.6 5848.9 5879.8 4045.5 4073.2 4081.2 4098.6 4122.6 5514.8 5649.2 5671.5 5684.7 5714.4 5492.9 5508.6 5515.6 5558.3 5649.6 5303.8 5511.4 5529.9 5578.7 5620.9 5481.7 5483.4 5494.5 5498.6 5499.6 5486.1 5531.8 5571.5 5574.1 5645.7 5305.8 5413.2 5449.6 5467.0 5490.2 06:21:03 INFO - PROCESS | 13563 | 06:21:03 INFO - PROCESS | 13563 | [#5] yui.html Cycles:180 Average:15381.83 Median:4543.30 stddev:17824.16 (392.3%) stddev-sans-first:17840.54 06:21:03 INFO - PROCESS | 13563 | Values: 803.2 841.5 843.2 874.7 878.8 14657.3 15036.3 15241.8 15259.2 15282.2 13509.2 13573.5 13579.5 13580.7 13587.5 689.6 814.6 816.3 830.6 850.8 824.1 829.4 830.1 832.1 832.4 887.5 890.2 894.1 894.7 894.9 734.3 845.9 876.9 878.9 887.1 636.0 636.0 636.2 636.3 636.7 14256.4 14271.9 14280.1 14287.4 14299.2 13770.5 14129.8 14185.6 14203.2 14243.6 12190.3 12220.7 12311.1 12533.0 12550.5 4496.3 4533.7 4533.7 4534.5 4537.2 53532.2 53740.5 54413.7 54450.5 54460.5 11091.4 11149.6 11265.6 11321.0 11371.1 19737.7 19757.3 19800.0 19846.0 19847.4 7915.3 7922.1 7977.1 8294.9 8359.0 4549.4 4669.0 4844.2 4900.5 5039.6 3336.8 3363.8 3406.5 3429.4 3437.0 671.6 716.8 718.7 726.0 729.3 747.6 769.3 786.3 794.3 802.5 10058.0 10282.4 10407.9 10412.2 10519.3 722.7 724.6 742.1 743.1 756.0 4643.3 4654.6 4676.3 4761.8 4807.1 64985.4 65906.3 66008.7 67417.3 67717.0 56184.2 57854.4 58211.7 58554.7 60437.7 51218.5 52361.7 52433.5 53229.5 54374.0 9239.8 9467.3 9478.4 9508.1 9511.5 34654.0 35171.3 35415.6 35573.0 35926.3 44993.0 46345.0 46735.8 47341.1 49115.3 11753.4 11929.9 12020.9 12070.5 12264.5 10805.6 13063.5 13227.5 13656.6 13797.2 13208.7 13264.3 13266.9 13785.4 14203.9 12978.3 13107.1 13271.7 13392.0 14021.4 12727.2 12992.2 13263.6 13361.3 13406.1 10751.5 11014.3 11286.3 11433.6 11557.0 10912.3 10947.6 10972.8 11010.4 11097.4 06:21:03 INFO - PROCESS | 13563 | -------- Summary: end -------- 06:21:03 INFO - PROCESS | 13563 | 06:21:04 INFO - TEST-INFO | 13563: exit 0 06:21:04 INFO - TEST-OK | dromaeo_css | took 1112540ms 06:21:04 INFO - TEST-START | kraken 06:21:04 INFO - operating with platform_type : linux_ 06:21:04 INFO - Initialising browser for kraken test... 06:21:04 INFO - TEST-INFO | started process 13745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbhbJP/profile http://localhost:37779/getInfo.html) 06:21:08 INFO - PROCESS | 13745 | __metrics Screen width/height:1600/1200 06:21:08 INFO - PROCESS | 13745 | colorDepth:24 06:21:08 INFO - PROCESS | 13745 | Browser inner width/height: 1024/697 06:21:08 INFO - PROCESS | 13745 | __metrics 06:21:09 ERROR - PROCESS | 13745 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:21:10 INFO - TEST-INFO | 13745: exit 0 06:21:10 INFO - Browser initialized. 06:21:10 INFO - Running cycle 1/1 for kraken test... 06:21:10 INFO - TEST-INFO | started process 13831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbhbJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:21 INFO - PROCESS | 13831 | RSS: Main: 152449024 06:21:21 INFO - PROCESS | 13831 | 06:21:24 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37779/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:25 INFO - PROCESS | 13831 | RSS: Main: 208289792 06:21:25 INFO - PROCESS | 13831 | 06:21:28 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37779/tests/kraken/driver.html?testName=audio-dft) 06:21:28 INFO - PROCESS | 13831 | RSS: Main: 196960256 06:21:28 INFO - PROCESS | 13831 | 06:21:31 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37779/tests/kraken/driver.html?testName=audio-fft) 06:21:32 INFO - PROCESS | 13831 | RSS: Main: 264527872 06:21:32 INFO - PROCESS | 13831 | 06:21:34 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37779/tests/kraken/driver.html?testName=audio-oscillator) 06:21:35 INFO - PROCESS | 13831 | RSS: Main: 173608960 06:21:35 INFO - PROCESS | 13831 | 06:21:37 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:38 INFO - PROCESS | 13831 | RSS: Main: 177811456 06:21:38 INFO - PROCESS | 13831 | 06:21:41 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37779/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:41 INFO - PROCESS | 13831 | RSS: Main: 213970944 06:21:41 INFO - PROCESS | 13831 | 06:21:45 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37779/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:46 INFO - PROCESS | 13831 | RSS: Main: 211304448 06:21:46 INFO - PROCESS | 13831 | 06:21:48 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37779/tests/kraken/driver.html?testName=json-parse-financial) 06:21:49 INFO - PROCESS | 13831 | RSS: Main: 213422080 06:21:49 INFO - PROCESS | 13831 | 06:21:51 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:51 INFO - PROCESS | 13831 | RSS: Main: 201494528 06:21:51 INFO - PROCESS | 13831 | 06:21:53 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:54 INFO - PROCESS | 13831 | RSS: Main: 204025856 06:21:54 INFO - PROCESS | 13831 | 06:21:56 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:57 INFO - PROCESS | 13831 | RSS: Main: 212553728 06:21:57 INFO - PROCESS | 13831 | 06:21:59 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:00 INFO - PROCESS | 13831 | RSS: Main: 223019008 06:22:00 INFO - PROCESS | 13831 | 06:22:03 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:03 INFO - PROCESS | 13831 | RSS: Main: 219885568 06:22:03 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | Cycle 1(1): loaded http://localhost:37779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37779/tests/kraken/driver.html?testName=ai-astar) 06:22:05 INFO - PROCESS | 13831 | RSS: Main: 265625600 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | __start_tp_report 06:22:05 INFO - PROCESS | 13831 | _x_x_mozilla_page_load 06:22:05 INFO - PROCESS | 13831 | _x_x_mozilla_page_load_details 06:22:05 INFO - PROCESS | 13831 | |i|pagename|runs| 06:22:05 INFO - PROCESS | 13831 | |0;ai-astar;114;106;110;110;109;110;110;109;110;113 06:22:05 INFO - PROCESS | 13831 | |1;audio-beat-detection;157;133;157;215;132;155;150;126;189;124 06:22:05 INFO - PROCESS | 13831 | |2;audio-dft;160;161;161;160;160;159;161;161;161;160 06:22:05 INFO - PROCESS | 13831 | |3;audio-fft;74;75;76;150;75;76;75;73;141;77 06:22:05 INFO - PROCESS | 13831 | |4;audio-oscillator;92;93;152;91;92;91;130;92;91;129 06:22:05 INFO - PROCESS | 13831 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;118;117;117 06:22:05 INFO - PROCESS | 13831 | |6;imaging-darkroom;145;145;146;145;145;145;145;147;146;146 06:22:05 INFO - PROCESS | 13831 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;94;95 06:22:05 INFO - PROCESS | 13831 | |8;json-parse-financial;57;56;57;57;57;56;57;108;56;54 06:22:05 INFO - PROCESS | 13831 | |9;json-stringify-tinderbox;58;60;59;58;60;59;59;59;59;59 06:22:05 INFO - PROCESS | 13831 | |10;stanford-crypto-aes;78;77;78;78;80;80;80;82;79;78 06:22:05 INFO - PROCESS | 13831 | |11;stanford-crypto-ccm;123;139;122;133;120;118;122;128;190;122 06:22:05 INFO - PROCESS | 13831 | |12;stanford-crypto-pbkdf2;167;165;163;166;162;163;166;166;169;171 06:22:05 INFO - PROCESS | 13831 | |13;stanford-crypto-sha256-iterative;64;64;65;64;64;62;64;64;64;64 06:22:05 INFO - PROCESS | 13831 | __end_tp_report 06:22:05 INFO - PROCESS | 13831 | __start_cc_report 06:22:05 INFO - PROCESS | 13831 | _x_x_mozilla_cycle_collect,1855 06:22:05 INFO - PROCESS | 13831 | __end_cc_report 06:22:05 INFO - PROCESS | 13831 | __startTimestamp1462972925622__endTimestamp 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | ------- Summary: start ------- 06:22:05 INFO - PROCESS | 13831 | Number of tests: 14 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:2.18 (2.0%) stddev-sans-first:1.80 06:22:05 INFO - PROCESS | 13831 | Values: 114.0 106.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 113.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:156.00 stddev:29.04 (18.6%) stddev-sans-first:30.78 06:22:05 INFO - PROCESS | 13831 | Values: 157.0 133.0 157.0 215.0 132.0 155.0 150.0 126.0 189.0 124.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 06:22:05 INFO - PROCESS | 13831 | Values: 160.0 161.0 161.0 160.0 160.0 159.0 161.0 161.0 161.0 160.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#3] audio-fft Cycles:10 Average:89.20 Median:75.00 stddev:29.77 (39.7%) stddev-sans-first:31.06 06:22:05 INFO - PROCESS | 13831 | Values: 74.0 75.0 76.0 150.0 75.0 76.0 75.0 73.0 141.0 77.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:91.50 stddev:22.73 (24.8%) stddev-sans-first:23.59 06:22:05 INFO - PROCESS | 13831 | Values: 92.0 93.0 152.0 91.0 92.0 91.0 130.0 92.0 91.0 129.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:22:05 INFO - PROCESS | 13831 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:22:05 INFO - PROCESS | 13831 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 147.0 146.0 146.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:22:05 INFO - PROCESS | 13831 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:57.00 stddev:16.37 (28.7%) stddev-sans-first:17.28 06:22:05 INFO - PROCESS | 13831 | Values: 57.0 56.0 57.0 57.0 57.0 56.0 57.0 108.0 56.0 54.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 06:22:05 INFO - PROCESS | 13831 | Values: 58.0 60.0 59.0 58.0 60.0 59.0 59.0 59.0 59.0 59.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:1.49 (1.9%) stddev-sans-first:1.54 06:22:05 INFO - PROCESS | 13831 | Values: 78.0 77.0 78.0 78.0 80.0 80.0 80.0 82.0 79.0 78.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:125.50 stddev:21.47 (17.1%) stddev-sans-first:22.54 06:22:05 INFO - PROCESS | 13831 | Values: 123.0 139.0 122.0 133.0 120.0 118.0 122.0 128.0 190.0 122.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:2.78 (1.7%) stddev-sans-first:2.92 06:22:05 INFO - PROCESS | 13831 | Values: 167.0 165.0 163.0 166.0 162.0 163.0 166.0 166.0 169.0 171.0 06:22:05 INFO - PROCESS | 13831 | 06:22:05 INFO - PROCESS | 13831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 06:22:05 INFO - PROCESS | 13831 | Values: 64.0 64.0 65.0 64.0 64.0 62.0 64.0 64.0 64.0 64.0 06:22:05 INFO - PROCESS | 13831 | -------- Summary: end -------- 06:22:05 INFO - PROCESS | 13831 | 06:22:06 INFO - TEST-INFO | 13831: exit 0 06:22:06 INFO - TEST-OK | kraken | took 62195ms 06:22:06 INFO - SUITE-END | took 1174s 06:22:06 INFO - Completed test suite (00:19:34) 06:22:06 INFO - javascript benchmark 06:22:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.873525058996, 3196.0252123102455, 3198.200449887528, 3225.6451790303063, 3228.354329134174, 5287.709175995319, 5320.654157479771, 5349.170878513832, 5430.72846357682, 5458.4541545845395, 5292.497212764791, 5314.627976041678, 5342.038433082053, 5437.891242175154, 5469.808556700516, 4711.411073615789, 4741.502142275063, 4955.157623204064, 4992.950070499303, 5039.496050394968, 4937.77779999899, 4962.131626965267, 4972.154733695281, 4991.875203119933, 4996.800127994876, 4688.906221875561, 4740.028294199698, 4775.21209000518, 4819.0, 4832.879178020543, 4841.709497430165, 4842.4189097308545, 4851.733154676492, 4907.4356449008465, 4913.115639184945, 4813.422389313269, 4843.055604157191, 4851.902961940777, 4864.610831133501, 4894.951050489485, 5194.532492075731, 5287.365516138049, 5291.3385826771655, 5350.759215835296, 5355.544778693816, 5705.172749951275, 5723.599348045638, 5749.367569567345, 5781.739821708034, 5829.387914269026, 5833.38749431312, 5842.649441033509, 5848.619839710448, 5858.648481091105, 5922.496587790043, 5286.07493688603, 5390.380106287748, 5393.919091213635, 5402.594805389612, 5417.674939503642, 5944.286685597756, 5991.700414979234, 5996.580239383288, 6015.037593985029, 6018.0, 5503.834884953458, 5735.627184233012, 5738.024535828919, 5767.625104368202, 5794.101914203306, 5681.715914204273, 5720.056190728483, 5724.885502290014, 5754.136879468029, 5759.136129580513, 5705.857353566111, 5715.742791574389, 5717.485426311652, 5721.828345149652, 5724.542036637059, 5498.917516237259, 5677.120046392815, 5725.971370143206, 5734.741936612862, 5737.627054241461, 4309.784510774449, 4333.046729719456, 4336.6530677545725, 4373.234683930299, 4375.409319741858, 3899.668528175137, 3903.965449155976, 3918.3338832398563, 3927.430522574268, 3953.6639385652543, 5338.733063346895, 5392.865178370494, 5412.107002344648, 5475.151351540518, 5518.061929471999, 5686.545076393879, 5774.797882074107, 5789.334226563915, 5794.0439827428845, 5796.710164491843, 5407.621466497386, 5416.0, 5421.566274698014, 5425.023495770799, 5477.096279113981, 4793.18515852299, 4914.410270767531, 4956.677815941952, 4958.057968985881, 4962.949341735824, 5967.522598192134, 5985.670788106609, 5990.580659353804, 5994.070919007474, 5997.310309314485, 5750.7987220447085, 5758.856028599151, 5799.4780469757925, 5802.216700745515, 5804.82585522435, 5803.709814509342, 5946.494547963472, 5989.221401217814, 5999.70001499932, 6098.0852872069545, 5758.942410575841, 5760.452756988079, 5767.769289228384, 5774.538036956949, 5786.797462088806, 5827.213326201078, 5843.649381037151, 5898.469137777621, 5898.9705051476185, 5904.202932604044, 5486.862828429162, 5592.524635406036, 5609.859753506195, 5623.831285061455, 5679.5172410345585, 5658.236138121301, 5658.434156584309, 5662.065759149694, 5664.0371136906, 5676.489115979582, 5401.729913504388, 5578.386377498391, 5591.664500130005, 5593.524550413098, 5593.9440605595055, 5671.291088613923, 5695.544356451557, 5705.201271822031, 5785.479306862402, 5793.797217097382, 5622.437756224344, 5627.465390787868, 5629.0, 5637.802676906289, 5674.092145256739], "value": 5315.621641367511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.2078341681191, 648.1412128929167, 656.0683828962872, 659.5976454362841, 663.3234101216759, 43962.12075758487, 45700.0, 45723.77138114309, 48944.021119577585, 49063.50936490634, 45837.77081114598, 46159.0, 46273.768631156796, 46308.536914630844, 46344.304835427494, 8816.0, 8967.686130985418, 8970.147835955573, 8972.371933964625, 8974.46153230805, 8858.645654173857, 8926.152015558544, 8940.016598174196, 8943.195112439878, 8947.597358118901, 8910.465372077664, 8950.507722075283, 8967.730968070935, 8973.506457144855, 8974.102589741005, 8884.466931984069, 8919.331050171264, 8919.331050171264, 8925.642974281021, 8925.999999999967, 8818.86771698425, 8910.777230569223, 8917.866232006525, 8925.285977121815, 8929.06244844295, 43040.13919721588, 43196.3520547192, 43264.78367608173, 43387.13225735499, 43452.78273608643, 3451.361498122855, 3660.267946410702, 4077.429159917614, 4286.185624731291, 4378.824847006116, 33700.32599348024, 34150.658493414994, 34865.47701784475, 36459.0, 36465.088372790626, 4365.759883206422, 4441.089576636814, 4481.193385190664, 4516.683832131752, 4628.773375055613, 339861.0, 343594.0, 343622.0, 343706.0, 343788.0, 53904.0, 59441.70279148577, 61644.691776541724, 62039.37960620336, 62774.37225627685, 64112.0, 64321.0, 64409.35590644128, 64499.35500644933, 64749.67625161844, 16080.919595401949, 16086.919565402332, 16118.75821862673, 16144.67710645804, 16147.0, 12724.681882953, 12906.870931290567, 13351.132176408502, 13380.19718816874, 13383.799243011363, 19387.806121938884, 19476.51308717265, 19796.60406791856, 20342.694859577117, 20533.897330513253, 7033.402160816286, 7186.532875363085, 7394.334509894135, 7460.962695186489, 7473.551586904803, 1005.1305620638095, 1013.2096964367805, 1022.8374046370528, 1112.783007313566, 1133.8072527670315, 33126.8343658285, 33180.33639327248, 33681.49477757836, 33698.32603347919, 34379.82810085933, 1145.5495400369623, 1145.6391236760394, 1224.1981502116128, 1252.1047451072527, 1298.214580178997, 17667.911660441616, 17961.461156165336, 18018.2792688291, 18056.90971545134, 18103.366382176824, 519926.0, 522825.0, 524927.0, 525015.0, 527005.0, 59870.70064649649, 60275.095873561055, 60340.698296508235, 60407.69796150991, 60427.0, 1393.3103113958655, 1415.1084816565499, 1439.3810661415691, 1448.8116544849313, 1452.194032312056, 30986.845065774527, 31105.68894311028, 31411.685883140875, 32305.51541726829, 33138.337233254715, 51969.740151299, 52100.21849672182, 52343.0, 52441.7377913108, 52531.73734131305, 412414.0, 416821.0, 419410.0, 420696.0, 420965.0, 25645.743542564334, 27128.0, 27475.587866181624, 28255.858720706266, 28280.717192827808, 48669.2699609499, 48865.26702099542, 49064.509354906, 49473.55790863074, 49635.25547116868, 41297.1740565193, 41687.791561042, 42548.78725606476, 42669.35995960001, 42810.57189428191, 41565.79217103895, 41715.7914210427, 42516.0, 42911.0, 46215.76892115518, 42525.57474425216, 43389.783051084545, 43792.562074378846, 43931.560684392745, 44015.0, 36005.81997090102, 37694.8115259422, 38025.429618555194, 38216.0, 38591.0798238852, 28253.71746282511, 28468.85765571159, 28541.857290713415, 28757.28106797347, 29058.564121538617], "value": 20721.507198790823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.52459785957916, 403.2318433384403, 403.90104424416023, 410.2492438836929, 421.83759252687724, 13294.800577991338, 18883.20609542093, 19713.310034148806, 19728.408147755556, 19765.50586235345, 14531.91010674201, 18403.26386944524, 18714.71927921079, 18895.33866314679, 19802.801971980276, 5711.942880571203, 5897.0, 5909.379515150912, 5925.377835327293, 5951.761929522814, 5857.004309267435, 5861.589688721791, 5879.0593505039205, 5889.705514724268, 5907.852303692399, 4261.2329780639475, 4399.9660079881205, 5456.454354564532, 6466.708998095097, 6475.320091390383, 6453.257875344349, 6516.5112616553715, 6577.868442631145, 6581.341865813428, 6586.407223349897, 5612.214289999403, 5686.2607860977805, 5696.715164241813, 5737.598368114233, 5738.82783516491, 22905.88547057254, 23036.884815575984, 23153.53692926132, 23641.172558960352, 23881.283561493183, 2364.606789257421, 2552.719200887901, 2557.360659835041, 2592.896284148632, 2593.753593408623, 13687.452501899912, 14436.711265774626, 14500.057496262814, 14558.272086395638, 15259.923700381538, 1949.580840119381, 2004.6692295771181, 2030.9743579492263, 2049.3237231713497, 2071.730675012239, 75641.0, 79062.20937790607, 79338.60330698367, 79746.60126699446, 79773.0, 10440.321379110486, 10720.624778132727, 10771.246012779187, 11180.09938310489, 11213.943930280297, 15208.315625796866, 15332.846671533365, 15342.539723808304, 15356.155411452253, 15361.926139970961, 8629.093945135795, 8649.610767515476, 8711.520866352284, 8799.560021999003, 8842.77893052666, 8710.041895391501, 8719.171678690514, 8731.519766412908, 8747.387682862138, 8893.644254229888, 5951.464368206882, 6143.539234557426, 6674.2658307586125, 6744.840291781791, 6791.0, 1793.1213705284317, 1797.8022417534062, 1803.801581825998, 1809.4842969753556, 1854.063697832613, 939.3655040229951, 985.6993616946756, 1012.9161796877271, 1023.3194925374543, 1100.4620146229909, 18849.340273090376, 19435.708464373045, 20152.798472015387, 20273.08771105304, 20409.795902041085, 1048.6434612231878, 1075.7955988362187, 1082.8429877667695, 1095.9178061645248, 1149.1840793037038, 11019.779604408028, 11497.482613282422, 11568.710782230342, 11591.0, 11596.768064638829, 454428.0, 459458.0, 463852.0, 466607.0, 466809.0, 79778.20221797824, 81584.0, 81866.0, 82196.58901705572, 82732.17267827365, 1037.4812593703148, 1057.8413238014205, 1061.8938106189319, 1063.3726101600093, 1072.0940805019902, 16435.342586296414, 17905.910470447565, 17923.28306867711, 17927.193276302336, 17970.0, 37723.622763773106, 40671.98320041904, 41003.58996410117, 41410.79500663567, 43115.7844210777, 50821.74589127031, 52317.47682523126, 55585.722071389384, 55827.0, 56049.0, 7206.135263768172, 7511.173770885089, 7889.13219545838, 8821.161989610977, 9059.094090590888, 9239.445633261757, 12861.164024338388, 13434.93282533581, 13546.390412431267, 13961.860381396462, 6417.197850268716, 10722.177229870784, 10897.455127243447, 12231.877681223074, 12466.439010244741, 12357.93821030889, 12425.93787031059, 12581.559645412366, 12698.30159341245, 12829.358532073173, 12314.876851231731, 12443.626691199279, 12503.687407814878, 12720.87279127197, 12919.741605167656, 8836.867446988428, 9072.319576031692, 9134.634614615341, 9148.222401095982, 9211.124943130391, 10425.582976680847, 12147.21043132229, 12151.331676757509, 12160.635180944586, 12401.441935113122], "value": 9461.8225385172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.6476798416402, 1515.0606623893188, 1536.0092740182579, 1674.2884274183477, 1839.3562253211387, 7668.309852113309, 8559.144085591446, 8729.388942774009, 8819.470831750099, 9068.682596109138, 8758.518281494515, 8910.821783564325, 8915.286777057836, 8942.418742781714, 8951.641934322635, 2065.070718176819, 2259.5029093599383, 2325.023490134148, 2372.9288121356344, 2399.520095980802, 2373.3354660694945, 2389.569877422063, 2391.234804862445, 2391.4141035446255, 2393.282015395383, 2338.240071976606, 2384.940376490584, 2386.1052105460453, 2386.2364043506086, 2391.6651668766385, 2047.8771273723623, 2301.1945818963313, 2348.7181538215355, 2357.0807385119815, 2369.3484291819714, 2240.8991595378084, 2246.056656204398, 2246.786555277246, 2251.0658076898067, 2313.548857972696, 8849.823003539957, 8961.551922403918, 8967.372283940127, 8979.371443998923, 8990.0, 5152.175651895679, 5288.762005709752, 5293.232481290192, 5299.4435584263865, 5303.124984377573, 3307.0, 3357.5635167428077, 3398.9660103398896, 3461.463473161664, 3480.8085555294447, 1090.569225156059, 1097.7310558913039, 1130.0168853097775, 1132.898039176478, 1143.3540049871879, 12102.031837452983, 12105.15263931525, 12109.39453027354, 12115.030797536176, 12134.817977730341, 4653.837115700934, 4691.53084691535, 4758.976205118952, 4777.498362671939, 4798.904021919612, 10246.53890574926, 10258.487075646337, 10261.589536418609, 10270.845937310796, 10286.485675716185, 4851.733154676456, 5263.289455923478, 5280.894382112413, 5284.0, 5289.629725919149, 4734.905301893943, 4873.878153046131, 4889.364382630307, 4909.484504127086, 4921.9507804922205, 4005.048380311294, 4025.7383270087353, 4061.1877624474632, 4069.4302797608357, 4070.6539944105084, 1269.504893091695, 1275.7576060548465, 1276.7574160909398, 1291.464042422403, 1292.3925754895183, 891.790429249126, 920.9539523023822, 953.9666111686058, 1003.4731765823001, 1058.9841152382721, 6155.230596175478, 6256.092866534418, 6259.874802504016, 6351.809445716636, 6475.32009139043, 472.0865125981237, 475.0593824228048, 479.0825569035328, 483.77262686537273, 483.9008003359303, 4283.678724095706, 4355.1289742051085, 4423.137488189772, 4459.554044595515, 4521.88695282614, 10688.839667404995, 10939.726506837234, 11165.776684466266, 11176.27354221973, 11182.16133789969, 10428.374297542172, 10971.39657318839, 11010.559577616967, 11086.501107450184, 11102.0, 8026.077001144943, 8227.382946279053, 8345.082040975487, 8348.499090054616, 8445.746627601182, 6244.344343843831, 6390.52071094679, 6486.416222539994, 6498.610083394822, 6554.737810487718, 10159.492025398848, 10448.2163837714, 10465.581376744845, 10645.467726613793, 10701.304415212986, 10400.531976060944, 10531.210159237935, 10635.14918806478, 10691.518881650189, 10801.621943231949, 7112.964435177791, 7586.9620651898595, 7875.054993400829, 7948.046234451903, 8084.0, 8725.563721813756, 8736.03903570594, 8771.342149338698, 8802.07578204305, 8809.383343165917, 7733.149353570991, 7822.256885595859, 7834.059912810271, 7972.880406793786, 8041.517508949481, 7399.149097853816, 7667.808304792202, 7725.884111738441, 7864.882026769717, 7873.0, 7010.298970102949, 7177.892331615134, 7269.818254543678, 7278.599677017814, 7289.088863892013, 5349.839504814861, 5378.381486128988, 5476.17857321405, 5478.233047373451, 5593.804216852391, 5527.336719593674, 5530.834074977757, 5546.195801608664, 5635.971820141037, 5687.146927960839], "value": 4632.61964779108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6825243009421, 329.28545057225824, 341.3667646515713, 348.67747333716306, 351.63078767294337, 5290.656107353019, 5295.152775555912, 5306.416294207634, 5350.411454739976, 5375.623706340558, 5265.131253343204, 5285.048691235576, 5285.180796976475, 5311.282976798131, 5325.600579956499, 3764.454154147647, 3901.687864970803, 3921.5294264650756, 4021.899452513696, 4028.0, 4035.233305671913, 4079.5104587449546, 4086.5913408659194, 4092.85675001375, 4100.118474527976, 4019.919601607966, 4039.030632648158, 4047.8178481968234, 4052.7365721228175, 4067.776272305022, 3896.5713771485116, 3923.8038098095267, 4048.210598933209, 4052.675785937118, 4070.470838790938, 3604.891853244407, 3638.199596088856, 3638.6725194732603, 3647.544056992876, 3660.396034654279, 5029.949700503022, 5040.59675225981, 5060.898782024339, 5063.746812659389, 5074.797008119671, 4435.3125265583885, 4689.531046895318, 4696.553827386393, 4702.952970470285, 4736.857894263143, 5485.945140548583, 5513.61404701671, 5515.420880807497, 5520.309961254843, 5530.944690553083, 3941.310270702644, 3959.6238357356006, 3985.9800700996598, 3995.5604883462797, 4003.3594624860175, 5565.749541270652, 5806.361300256968, 5810.796622118206, 5819.563532735019, 5821.767129314865, 3951.150502641888, 3999.2601368746873, 4019.21625283067, 4035.858744943913, 4046.4537287466405, 4031.9193616127513, 4119.0937993641355, 4158.91682166361, 4170.22850772608, 4171.0823618803815, 4618.676692631483, 4709.7174169549935, 4720.740359280273, 4731.172044892199, 4752.95247047532, 5629.0, 5632.493075623213, 5632.577556683265, 5637.43625637433, 5638.323401191883, 1394.958151255464, 1410.7601707709714, 1412.1174266083697, 1416.5396246219814, 1417.9929100354432, 840.3949156607233, 877.6313948141795, 915.7134226411902, 920.8305452075826, 931.3713243560569, 4714.175019371665, 4751.239801631791, 4774.188387974053, 4777.546133117348, 4787.640926930494, 4992.825251116194, 5062.063518249062, 5065.822696205615, 5081.8729531762, 5086.491350864958, 4587.38070360497, 4791.586481987822, 4810.206315957827, 4822.421309442819, 4824.903501929942, 2701.5812549054926, 2707.7563019327963, 2712.850793206353, 2717.3070866928806, 2717.3750037491486, 5210.557102646242, 5216.817411390583, 5218.086834803894, 5237.454950789526, 5259.36887573486, 4936.75316234194, 5090.414602320707, 5130.307408499804, 5157.6647517911215, 5579.553635709133, 5764.423557644286, 5941.376155503696, 5951.345352011275, 5965.777015711768, 5972.432618901197, 5627.606067575231, 5635.971820140873, 5738.741756620879, 5759.596828221985, 5810.273715785527, 5307.65500242483, 5589.580781441489, 5590.720463976866, 5617.32592088952, 5642.85892852682, 5821.301443826768, 5839.970800145972, 5848.590598658053, 5848.853778655397, 5879.823605291848, 4045.474088368493, 4073.185362927367, 4081.1633615109427, 4098.569650186688, 4122.56713045126, 5514.779408823602, 5649.152627105803, 5671.517920976763, 5684.71576421169, 5714.3999880012, 5492.928878868583, 5508.586855985737, 5515.558755299647, 5558.305211848519, 5649.576281778801, 5303.761330740203, 5511.448855114457, 5529.944700552943, 5578.721063946705, 5620.859478512906, 5481.698506582176, 5483.396826349178, 5494.532964698045, 5498.615096943336, 5499.615026948075, 5486.0923710433535, 5531.834044978657, 5571.526420254324, 5574.108142697149, 5645.661260324394, 5305.814296499604, 5413.188021796762, 5449.64577302474, 5467.043267428264, 5490.231367608618], "value": 4138.533213995552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.1767438375664, 841.4993079117927, 843.1905370843989, 874.724461794535, 878.7715194049549, 14657.340419681113, 15036.323365448554, 15241.847581524182, 15259.16074615897, 15282.235888205601, 13509.189448633064, 13573.52492662757, 13579.52471663492, 13580.660483487918, 13587.524436644719, 689.5965859971898, 814.5642081486405, 816.302061737215, 830.6013113705425, 850.8213275212213, 824.1017291152642, 829.4276948905236, 830.0537387378394, 832.0847068224934, 832.4381042796089, 887.5340446265698, 890.1899271662788, 894.065701342099, 894.6868595991416, 894.8523493623577, 734.3024127079296, 845.8773477845708, 876.8816209811721, 878.8945326560789, 887.0951629338072, 636.0, 636.045931103345, 636.2396935661886, 636.3318515558691, 636.7262077306756, 14256.35846386915, 14271.928640356731, 14280.143191408548, 14287.357068931922, 14299.213543255117, 13770.518031868936, 14129.78805317921, 14185.645358866008, 14203.218822964733, 14243.643908902257, 12190.268583884996, 12220.694482637917, 12311.138220324581, 12532.99736021116, 12550.497980080785, 4496.280595104768, 4533.659975501851, 4533.727976321398, 4534.501204867462, 4537.160625284333, 53532.197017044775, 53740.46259537394, 54413.72793136049, 54450.455495445334, 54460.45539544593, 11091.389973551532, 11149.609763658233, 11265.605703800327, 11321.0, 11371.147163962736, 19737.703934440993, 19757.308494202633, 19800.0, 19846.0, 19847.404577862686, 7915.287624113857, 7922.128565857866, 7977.122516523178, 8294.875576866352, 8359.0, 4549.431321084864, 4668.953310466852, 4844.224924012141, 4900.485449027872, 5039.571636410873, 3336.833158342122, 3363.764536482423, 3406.5401170842115, 3429.4341433663167, 3436.9656303437146, 671.5601281160848, 716.8494269660202, 718.7161071376881, 726.0234983946583, 729.3472342253654, 747.6075060593123, 769.2730369800597, 786.3119770201074, 794.3327604811985, 802.5265093594807, 10058.0, 10282.434466104436, 10407.94796026015, 10412.219083568763, 10519.263651544472, 722.7073035420663, 724.6449239872425, 742.1354122447397, 743.141671369569, 755.9546427214385, 4643.326717625925, 4654.604358629486, 4676.275177347517, 4761.809527618926, 4807.110684523374, 64985.35014649793, 65906.34093659098, 66008.66995664992, 67417.32582674209, 67717.0, 56184.15723764147, 57854.42145578575, 58211.70894145502, 58554.707226464445, 60437.69781151066, 51218.48781512212, 52361.7381913088, 52433.47566524362, 53229.46770532322, 54374.0, 9239.815203695754, 9467.289953253396, 9478.431294122374, 9508.096730810563, 9511.476868772284, 34654.0, 35171.29657406889, 35415.645843541235, 35573.0, 35926.28147437089, 44993.0, 46345.0, 46735.76632116818, 47341.08236470441, 49115.26327105168, 11753.353565553634, 11929.880701192877, 12020.879791202326, 12070.456829442872, 12264.509419623471, 10805.567777288821, 13063.477460901457, 13227.470901163846, 13656.590302290948, 13797.24115173675, 13208.735825283633, 13264.336783160996, 13266.933665331997, 13785.448582057006, 14203.857961420666, 12978.286194259406, 13107.14803537767, 13271.734565308447, 13392.0, 14021.3690383935, 12727.172733772275, 12992.220466772023, 13263.602091937257, 13361.331933403097, 13406.061575689608, 10751.462426878468, 11014.339139651647, 11286.266392684449, 11433.59982400612, 11557.0, 10912.290701104403, 10947.56209751601, 10972.780544389227, 11010.39442830652, 11097.445127743418], "value": 7016.775664344123, "unit": "score"}], "name": "dromaeo_css", "value": 7207.77821071016, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 113.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 157.0, 215.0, 132.0, 155.0, 150.0, 126.0, 189.0, 124.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 150.0, 75.0, 76.0, 75.0, 73.0, 141.0, 77.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 91.0, 92.0, 91.0, 130.0, 92.0, 91.0, 129.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 108.0, 56.0, 54.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 78.0, 80.0, 80.0, 80.0, 82.0, 79.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 139.0, 122.0, 133.0, 120.0, 118.0, 122.0, 128.0, 190.0, 122.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 163.0, 166.0, 162.0, 163.0, 166.0, 166.0, 169.0, 171.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 62.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1536.7, "alertThreshold": 2.0}]} 06:22:06 INFO - Return code: 0 06:22:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:22:06 ERROR - # TBPL SUCCESS # 06:22:06 INFO - Running post-action listener: _resource_record_post_action 06:22:06 INFO - ##### 06:22:06 INFO - ##### Finished run-tests step (success) 06:22:06 INFO - ##### 06:22:06 INFO - Running post-run listener: _resource_record_post_run 06:22:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542244864; Read time: 16; Write time: 483548 06:22:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256258048; Read time: 0; Write time: 268072 06:22:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285986816; Read time: 16; Write time: 215476 06:22:08 INFO - Running post-run listener: _upload_blobber_files 06:22:08 INFO - Blob upload gear active. 06:22:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:08 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 06:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:22:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:22:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:09 INFO - (blobuploader) - INFO - Done attempting. 06:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:22:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:09 INFO - (blobuploader) - INFO - Done attempting. 06:22:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:09 INFO - Return code: 0 06:22:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901e399b0a33e36842998858eeddbe7b2cbd82399b891db6ab1c82fbaccbaee604d0f912d267acf2a53bf34b6c351e6c5505a0250dcbfb74600e56cc7dd0a0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd11dbb7db01f487afe94dff4a9feed6e11a0ce25c33a28c07bc2c7d3df0d6e8071471b2bafd830ecfb334b780323da10415bab18ba3afa3ef9c96cedfb30022"} 06:22:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:09 INFO - Contents: 06:22:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901e399b0a33e36842998858eeddbe7b2cbd82399b891db6ab1c82fbaccbaee604d0f912d267acf2a53bf34b6c351e6c5505a0250dcbfb74600e56cc7dd0a0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd11dbb7db01f487afe94dff4a9feed6e11a0ce25c33a28c07bc2c7d3df0d6e8071471b2bafd830ecfb334b780323da10415bab18ba3afa3ef9c96cedfb30022"} 06:22:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:09 INFO - Copying logs to upload dir... 06:22:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.538095 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 06:22:09.871003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:22:09.875076) ========= 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=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901e399b0a33e36842998858eeddbe7b2cbd82399b891db6ab1c82fbaccbaee604d0f912d267acf2a53bf34b6c351e6c5505a0250dcbfb74600e56cc7dd0a0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd11dbb7db01f487afe94dff4a9feed6e11a0ce25c33a28c07bc2c7d3df0d6e8071471b2bafd830ecfb334b780323da10415bab18ba3afa3ef9c96cedfb30022"} build_url:https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/AIrobmLnT2yDINrPwj330g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901e399b0a33e36842998858eeddbe7b2cbd82399b891db6ab1c82fbaccbaee604d0f912d267acf2a53bf34b6c351e6c5505a0250dcbfb74600e56cc7dd0a0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd11dbb7db01f487afe94dff4a9feed6e11a0ce25c33a28c07bc2c7d3df0d6e8071471b2bafd830ecfb334b780323da10415bab18ba3afa3ef9c96cedfb30022"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:22:09.900680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:22:09.901070) ========= 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=41bf3e9aed84707956354da8000001c5-1462971696.920230-1553774585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004368 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:22:09.986161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:22:09.986861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:22:09.987625) ========= ========= Total master_lag: 0.17 =========