builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1460649676.04 results: success (0) buildid: 20160414074538 builduid: e44f1848eee34552bfde55587b277c28 revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.038873) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.039344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.039637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.090854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.091257) ========= 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-1460646420.773127-1544315099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 09:01:16-- 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% 224M=0s 2016-04-14 09:01:16 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.214885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.215201) ========= 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-1460646420.773127-1544315099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.265630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.265975) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 995e7890dd613843c3914a1d9d46676f400152c1 --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 995e7890dd613843c3914a1d9d46676f400152c1 --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-1460646420.773127-1544315099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 09:01:16,627 truncating revision to first 12 chars 2016-04-14 09:01:16,627 Setting DEBUG logging. 2016-04-14 09:01:16,627 attempt 1/10 2016-04-14 09:01:16,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/995e7890dd61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 09:01:16,859 unpacking tar archive at: fx-team-995e7890dd61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507211 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.787745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.788232) ========= script_repo_revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.788873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.789748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.800881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-14 09:01:16.801256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:17 INFO - MultiFileLogger online at 20160414 09:01:17 in /builds/slave/test 09:01:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:01:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:17 INFO - {'append_to_log': False, 09:01:17 INFO - 'base_work_dir': '/builds/slave/test', 09:01:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:01:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:17 INFO - 'branch': 'Fx-Team-Non-PGO', 09:01:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:17 INFO - 'config_files': ('talos/linux_config.py',), 09:01:17 INFO - 'default_actions': ('clobber', 09:01:17 INFO - 'read-buildbot-config', 09:01:17 INFO - 'download-and-extract', 09:01:17 INFO - 'populate-webroot', 09:01:17 INFO - 'create-virtualenv', 09:01:17 INFO - 'install', 09:01:17 INFO - 'run-tests'), 09:01:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:17 INFO - 'download_minidump_stackwalk': True, 09:01:17 INFO - 'download_symbols': 'ondemand', 09:01:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:17 INFO - 'installer_path': 'installer.exe', 09:01:17 INFO - 'log_level': 'info', 09:01:17 INFO - 'log_name': 'talos', 09:01:17 INFO - 'log_to_console': True, 09:01:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:17 INFO - 'opt_config_files': (), 09:01:17 INFO - 'pip_index': False, 09:01:17 INFO - 'sps_profile': False, 09:01:17 INFO - 'sps_profile_interval': 0, 09:01:17 INFO - 'suite': 'dromaeojs', 09:01:17 INFO - 'system_bits': '32', 09:01:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:17 INFO - 'title': 'talos-linux64-ix-026', 09:01:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:17 INFO - 'use_talos_json': True, 09:01:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:17 INFO - 'work_dir': 'build'} 09:01:17 INFO - ##### 09:01:17 INFO - ##### Running clobber step. 09:01:17 INFO - ##### 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: clobber 09:01:17 INFO - rmtree: /builds/slave/test/build 09:01:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:18 INFO - Running post-action listener: _resource_record_post_action 09:01:18 INFO - ##### 09:01:18 INFO - ##### Running read-buildbot-config step. 09:01:18 INFO - ##### 09:01:18 INFO - Running pre-action listener: _resource_record_pre_action 09:01:18 INFO - Running main action method: read_buildbot_config 09:01:18 INFO - Using buildbot properties: 09:01:18 INFO - { 09:01:18 INFO - "project": "", 09:01:18 INFO - "product": "firefox", 09:01:18 INFO - "script_repo_revision": "production", 09:01:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:01:18 INFO - "repository": "", 09:01:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:01:18 INFO - "buildid": "20160414074538", 09:01:18 INFO - "pgo_build": "False", 09:01:18 INFO - "basedir": "/builds/slave/test", 09:01:18 INFO - "buildnumber": 1564, 09:01:18 INFO - "slavename": "talos-linux64-ix-026", 09:01:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:01:18 INFO - "platform": "ubuntu64_hw", 09:01:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:01:18 INFO - "branch": "fx-team", 09:01:18 INFO - "repo_path": "integration/fx-team", 09:01:18 INFO - "revision": "995e7890dd613843c3914a1d9d46676f400152c1", 09:01:18 INFO - "stage_platform": "linux64", 09:01:18 INFO - "builduid": "e44f1848eee34552bfde55587b277c28", 09:01:18 INFO - "slavebuilddir": "test" 09:01:18 INFO - } 09:01:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:01:18 INFO - Running post-action listener: _resource_record_post_action 09:01:18 INFO - ##### 09:01:18 INFO - ##### Running download-and-extract step. 09:01:18 INFO - ##### 09:01:18 INFO - Running pre-action listener: _resource_record_pre_action 09:01:18 INFO - Running main action method: download_and_extract 09:01:18 INFO - mkdir: /builds/slave/test/build/tests 09:01:18 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')]} 09:01:18 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:01:30 INFO - Downloaded 1361 bytes. 09:01:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:30 INFO - Using the following test package requirements: 09:01:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:01:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'jsshell-linux-x86_64.zip'], 09:01:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01: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')]} 09:01:30 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:01:32 INFO - Downloaded 22202881 bytes. 09:01:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:01:33 INFO - Return code: 0 09:01:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:33 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:01:34 INFO - Downloaded 22202881 bytes. 09:01:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:01:36 INFO - Return code: 0 09:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:36 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:01:37 INFO - Downloaded 10841076 bytes. 09:01:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:01:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:01:37 INFO - Return code: 0 09:01:37 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')]} 09:01:37 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:01:40 INFO - Downloaded 54450742 bytes. 09:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:40 INFO - mkdir: /builds/slave/test/properties 09:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:40 INFO - Contents: 09:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - Running post-action listener: set_extra_try_arguments 09:01:41 INFO - ##### 09:01:41 INFO - ##### Running populate-webroot step. 09:01:41 INFO - ##### 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: populate_webroot 09:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:41 INFO - '--tppagecycles', 09:01:41 INFO - '7'], 09:01:41 INFO - 'tests': ['tsvgm']}}, 09:01:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['damp', 'tps']}, 09:01:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['damp', 'tps']}, 09:01:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['dromaeo_dom']}, 09:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tsvgx', 09:01:41 INFO - 'tsvgr_opacity', 09:01:41 INFO - 'tart', 09:01:41 INFO - 'tscrollx', 09:01:41 INFO - 'cart']}, 09:01:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:41 INFO - 'tsvgr_opacity', 09:01:41 INFO - 'tart', 09:01:41 INFO - 'tscrollx', 09:01:41 INFO - 'cart']}, 09:01:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tp5o']}, 09:01:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['tp5o']}, 09:01:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s', 09:01:41 INFO - '--xperf_path', 09:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:41 INFO - 'tests': ['tp5n']}, 09:01:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--xperf_path', 09:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:41 INFO - 'tests': ['tp5n']}}, 09:01:41 INFO - 'talos.zip': {'path': '', 09:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - ##### 09:01:41 INFO - ##### Running create-virtualenv step. 09:01:41 INFO - ##### 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: create_virtualenv 09:01:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:41 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 09:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:41 INFO - Using real prefix '/usr' 09:01:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:44 INFO - Installing pip.................done. 09:01:44 INFO - Return code: 0 09:01:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:44 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 09:01:44 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 09:01:44 INFO - Using env: {'DISPLAY': ':0', 09:01:44 INFO - 'HOME': '/home/cltbld', 09:01:44 INFO - 'LANG': 'en_US.UTF-8', 09:01:44 INFO - 'LANGUAGE': 'en_US:en', 09:01:44 INFO - 'LOGNAME': 'cltbld', 09:01:44 INFO - 'MAIL': '/var/mail/cltbld', 09:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:44 INFO - 'MOZ_NO_REMOTE': '1', 09:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:44 INFO - 'NO_EM_RESTART': '1', 09:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:44 INFO - 'PWD': '/builds/slave/test', 09:01:44 INFO - 'SHELL': '/bin/bash', 09:01:44 INFO - 'SHLVL': '1', 09:01:44 INFO - 'TERM': 'linux', 09:01:44 INFO - 'TMOUT': '86400', 09:01:44 INFO - 'USER': 'cltbld', 09:01:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:44 INFO - '_': '/tools/buildbot/bin/python'} 09:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:44 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 09:01:44 INFO - Cleaning up... 09:01:44 INFO - Return code: 0 09:01:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:44 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 09:01:44 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 09:01:44 INFO - Using env: {'DISPLAY': ':0', 09:01:44 INFO - 'HOME': '/home/cltbld', 09:01:44 INFO - 'LANG': 'en_US.UTF-8', 09:01:44 INFO - 'LANGUAGE': 'en_US:en', 09:01:44 INFO - 'LOGNAME': 'cltbld', 09:01:44 INFO - 'MAIL': '/var/mail/cltbld', 09:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:44 INFO - 'MOZ_NO_REMOTE': '1', 09:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:44 INFO - 'NO_EM_RESTART': '1', 09:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:44 INFO - 'PWD': '/builds/slave/test', 09:01:44 INFO - 'SHELL': '/bin/bash', 09:01:44 INFO - 'SHLVL': '1', 09:01:44 INFO - 'TERM': 'linux', 09:01:44 INFO - 'TMOUT': '86400', 09:01:44 INFO - 'USER': 'cltbld', 09:01:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:44 INFO - '_': '/tools/buildbot/bin/python'} 09:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:44 INFO - Downloading/unpacking psutil>=0.7.1 09:01:44 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 09:01:44 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 09:01:44 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 09:01:44 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 09:01:44 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 09:01:44 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 09:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:46 INFO - Installing collected packages: psutil 09:01:46 INFO - Running setup.py install for psutil 09:01:46 INFO - building 'psutil._psutil_linux' extension 09:01:46 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 09:01:46 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 09:01:46 INFO - building 'psutil._psutil_posix' extension 09:01:46 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 09:01:46 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 09:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:47 INFO - Successfully installed psutil 09:01:47 INFO - Cleaning up... 09:01:47 INFO - Return code: 0 09:01:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:01:47 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')]} 09:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:47 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')]} 09:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:47 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:47 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 09:01:47 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 09:01:47 INFO - Using env: {'DISPLAY': ':0', 09:01:47 INFO - 'HOME': '/home/cltbld', 09:01:47 INFO - 'LANG': 'en_US.UTF-8', 09:01:47 INFO - 'LANGUAGE': 'en_US:en', 09:01:47 INFO - 'LOGNAME': 'cltbld', 09:01:47 INFO - 'MAIL': '/var/mail/cltbld', 09:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:47 INFO - 'MOZ_NO_REMOTE': '1', 09:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:47 INFO - 'NO_EM_RESTART': '1', 09:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:47 INFO - 'PWD': '/builds/slave/test', 09:01:47 INFO - 'SHELL': '/bin/bash', 09:01:47 INFO - 'SHLVL': '1', 09:01:47 INFO - 'TERM': 'linux', 09:01:47 INFO - 'TMOUT': '86400', 09:01:47 INFO - 'USER': 'cltbld', 09:01:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:47 INFO - '_': '/tools/buildbot/bin/python'} 09:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:01:47 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 09:01:47 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 09:01:47 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 09:01:47 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 09:01:47 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 09:01:47 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 09:01:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:01:49 INFO - Installing collected packages: mozsystemmonitor 09:01:49 INFO - Running setup.py install for mozsystemmonitor 09:01:49 INFO - Successfully installed mozsystemmonitor 09:01:49 INFO - Cleaning up... 09:01:49 INFO - Return code: 0 09:01:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:49 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')]} 09:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:49 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')]} 09:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:49 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:49 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 09:01:49 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 09:01:49 INFO - Using env: {'DISPLAY': ':0', 09:01:49 INFO - 'HOME': '/home/cltbld', 09:01:49 INFO - 'LANG': 'en_US.UTF-8', 09:01:49 INFO - 'LANGUAGE': 'en_US:en', 09:01:49 INFO - 'LOGNAME': 'cltbld', 09:01:49 INFO - 'MAIL': '/var/mail/cltbld', 09:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:49 INFO - 'MOZ_NO_REMOTE': '1', 09:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:49 INFO - 'NO_EM_RESTART': '1', 09:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:49 INFO - 'PWD': '/builds/slave/test', 09:01:49 INFO - 'SHELL': '/bin/bash', 09:01:49 INFO - 'SHLVL': '1', 09:01:49 INFO - 'TERM': 'linux', 09:01:49 INFO - 'TMOUT': '86400', 09:01:49 INFO - 'USER': 'cltbld', 09:01:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:49 INFO - '_': '/tools/buildbot/bin/python'} 09:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:49 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 09:01:49 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 09:01:49 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 09:01:49 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 09:01:49 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 09:01:49 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 09:01:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:01:52 INFO - Downloading docopt-0.6.1.tar.gz 09:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:52 INFO - Running setup.py install for blobuploader 09:01:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:52 INFO - Running setup.py install for requests 09:01:52 INFO - Running setup.py install for docopt 09:01:52 INFO - Successfully installed blobuploader requests docopt 09:01:52 INFO - Cleaning up... 09:01:52 INFO - Return code: 0 09:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09: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')]} 09:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:52 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:52 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 09:01:52 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 09:01:52 INFO - Using env: {'DISPLAY': ':0', 09:01:52 INFO - 'HOME': '/home/cltbld', 09:01:52 INFO - 'LANG': 'en_US.UTF-8', 09:01:52 INFO - 'LANGUAGE': 'en_US:en', 09:01:52 INFO - 'LOGNAME': 'cltbld', 09:01:52 INFO - 'MAIL': '/var/mail/cltbld', 09:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:52 INFO - 'MOZ_NO_REMOTE': '1', 09:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:52 INFO - 'NO_EM_RESTART': '1', 09:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:52 INFO - 'PWD': '/builds/slave/test', 09:01:52 INFO - 'SHELL': '/bin/bash', 09:01:52 INFO - 'SHLVL': '1', 09:01:52 INFO - 'TERM': 'linux', 09:01:52 INFO - 'TMOUT': '86400', 09:01:52 INFO - 'USER': 'cltbld', 09:01:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:52 INFO - '_': '/tools/buildbot/bin/python'} 09:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:53 INFO - Running setup.py (path:/tmp/pip-15xeg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:53 INFO - Running setup.py (path:/tmp/pip-iwHLGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:53 INFO - Running setup.py (path:/tmp/pip-f8xxqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:53 INFO - Running setup.py (path:/tmp/pip-EpWVVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:53 INFO - Running setup.py (path:/tmp/pip-3FGa5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:53 INFO - Running setup.py (path:/tmp/pip-nRtBH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:53 INFO - Running setup.py (path:/tmp/pip-MCmcxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:53 INFO - Running setup.py (path:/tmp/pip-z7CqT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:53 INFO - Running setup.py (path:/tmp/pip-g8p9QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:53 INFO - Running setup.py (path:/tmp/pip-xTjIWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:53 INFO - Running setup.py (path:/tmp/pip-L1we0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:53 INFO - Running setup.py (path:/tmp/pip-OAK2I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:53 INFO - Running setup.py (path:/tmp/pip-c6hfas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:54 INFO - Running setup.py (path:/tmp/pip-cwarp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:54 INFO - Running setup.py (path:/tmp/pip-59lSTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:54 INFO - Running setup.py (path:/tmp/pip-mU0XBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:54 INFO - Running setup.py (path:/tmp/pip-ZSVJzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:54 INFO - Running setup.py install for manifestparser 09:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:54 INFO - Running setup.py install for mozcrash 09:01:54 INFO - Running setup.py install for mozdebug 09:01:54 INFO - Running setup.py install for mozdevice 09:01:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:54 INFO - Running setup.py install for mozfile 09:01:54 INFO - Running setup.py install for mozhttpd 09:01:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:54 INFO - Running setup.py install for mozinfo 09:01:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozInstall 09:01:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozleak 09:01:55 INFO - Running setup.py install for mozlog 09:01:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for moznetwork 09:01:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozprocess 09:01:55 INFO - Running setup.py install for mozprofile 09:01:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozrunner 09:01:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozscreenshot 09:01:55 INFO - Running setup.py install for moztest 09:01:56 INFO - Running setup.py install for mozversion 09:01:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:56 INFO - Cleaning up... 09:01:56 INFO - Return code: 0 09:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:56 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')]} 09:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:56 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')]} 09:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:56 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:56 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 09:01:56 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 09:01:56 INFO - Using env: {'DISPLAY': ':0', 09:01:56 INFO - 'HOME': '/home/cltbld', 09:01:56 INFO - 'LANG': 'en_US.UTF-8', 09:01:56 INFO - 'LANGUAGE': 'en_US:en', 09:01:56 INFO - 'LOGNAME': 'cltbld', 09:01:56 INFO - 'MAIL': '/var/mail/cltbld', 09:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:56 INFO - 'MOZ_NO_REMOTE': '1', 09:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:56 INFO - 'NO_EM_RESTART': '1', 09:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:56 INFO - 'PWD': '/builds/slave/test', 09:01:56 INFO - 'SHELL': '/bin/bash', 09:01:56 INFO - 'SHLVL': '1', 09:01:56 INFO - 'TERM': 'linux', 09:01:56 INFO - 'TMOUT': '86400', 09:01:56 INFO - 'USER': 'cltbld', 09:01:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:56 INFO - '_': '/tools/buildbot/bin/python'} 09:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:56 INFO - Running setup.py (path:/tmp/pip-tq2m2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:56 INFO - Running setup.py (path:/tmp/pip-03axcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:56 INFO - Running setup.py (path:/tmp/pip-KzUwQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:56 INFO - Running setup.py (path:/tmp/pip-yz0IU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:56 INFO - Running setup.py (path:/tmp/pip-bRTU6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:56 INFO - Running setup.py (path:/tmp/pip-bb7M19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:56 INFO - Running setup.py (path:/tmp/pip-QCcmO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:56 INFO - Running setup.py (path:/tmp/pip-xG8pJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:56 INFO - Running setup.py (path:/tmp/pip-4k3ZdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:56 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)) 09:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:57 INFO - Running setup.py (path:/tmp/pip-QRLIHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:57 INFO - Running setup.py (path:/tmp/pip-bzDShR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:57 INFO - Running setup.py (path:/tmp/pip-4_SghA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:57 INFO - Running setup.py (path:/tmp/pip-XEZvzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:57 INFO - Running setup.py (path:/tmp/pip-cH8Ok6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:57 INFO - Running setup.py (path:/tmp/pip-NbMNWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:57 INFO - Running setup.py (path:/tmp/pip-u8zgSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:57 INFO - Running setup.py (path:/tmp/pip-BXNOfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:57 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)) 09:01:57 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)) 09:01:57 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)) 09:01:57 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)) 09:01:57 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)) 09:01:57 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)) 09:01:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09: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 09: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 09: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 09: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 09: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 09: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 09:01:59 INFO - Downloading blessings-1.6.tar.gz 09:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:59 INFO - Installing collected packages: blessings 09:01:59 INFO - Running setup.py install for blessings 09:01:59 INFO - Successfully installed blessings 09:01:59 INFO - Cleaning up... 09:01:59 INFO - Return code: 0 09:01:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:59 INFO - Reading from file tmpfile_stdout 09:01:59 INFO - Current package versions: 09:01:59 INFO - argparse == 1.2.1 09:01:59 INFO - blessings == 1.6 09:01:59 INFO - blobuploader == 1.2.4 09:01:59 INFO - docopt == 0.6.1 09:01:59 INFO - manifestparser == 1.1 09:01:59 INFO - mozInstall == 1.12 09:01:59 INFO - mozcrash == 0.17 09:01:59 INFO - mozdebug == 0.1 09:01:59 INFO - mozdevice == 0.48 09:01:59 INFO - mozfile == 1.2 09:01:59 INFO - mozhttpd == 0.7 09:01:59 INFO - mozinfo == 0.9 09:01:59 INFO - mozleak == 0.1 09:01:59 INFO - mozlog == 3.1 09:01:59 INFO - moznetwork == 0.27 09:01:59 INFO - mozprocess == 0.22 09:01:59 INFO - mozprofile == 0.28 09:01:59 INFO - mozrunner == 6.11 09:01:59 INFO - mozscreenshot == 0.1 09:01:59 INFO - mozsystemmonitor == 0.0 09:01:59 INFO - moztest == 0.7 09:01:59 INFO - mozversion == 1.4 09:01:59 INFO - psutil == 3.1.1 09:01:59 INFO - requests == 1.2.3 09:01:59 INFO - wsgiref == 0.1.2 09:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:01:59 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 09:01:59 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 09:01:59 INFO - Using env: {'DISPLAY': ':0', 09:01:59 INFO - 'HOME': '/home/cltbld', 09:01:59 INFO - 'LANG': 'en_US.UTF-8', 09:01:59 INFO - 'LANGUAGE': 'en_US:en', 09:01:59 INFO - 'LOGNAME': 'cltbld', 09:01:59 INFO - 'MAIL': '/var/mail/cltbld', 09:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:59 INFO - 'MOZ_NO_REMOTE': '1', 09:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:59 INFO - 'NO_EM_RESTART': '1', 09:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:59 INFO - 'PWD': '/builds/slave/test', 09:01:59 INFO - 'SHELL': '/bin/bash', 09:01:59 INFO - 'SHLVL': '1', 09:01:59 INFO - 'TERM': 'linux', 09:01:59 INFO - 'TMOUT': '86400', 09:01:59 INFO - 'USER': 'cltbld', 09:01:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:59 INFO - '_': '/tools/buildbot/bin/python'} 09:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 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)) 09:02:00 INFO - Cleaning up... 09:02:00 INFO - Return code: 0 09:02:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:02:00 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')]} 09:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 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')]} 09:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:02:00 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 09:02:00 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 09:02:00 INFO - Using env: {'DISPLAY': ':0', 09:02:00 INFO - 'HOME': '/home/cltbld', 09:02:00 INFO - 'LANG': 'en_US.UTF-8', 09:02:00 INFO - 'LANGUAGE': 'en_US:en', 09:02:00 INFO - 'LOGNAME': 'cltbld', 09:02:00 INFO - 'MAIL': '/var/mail/cltbld', 09:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:00 INFO - 'MOZ_NO_REMOTE': '1', 09:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:00 INFO - 'NO_EM_RESTART': '1', 09:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:00 INFO - 'PWD': '/builds/slave/test', 09:02:00 INFO - 'SHELL': '/bin/bash', 09:02:00 INFO - 'SHLVL': '1', 09:02:00 INFO - 'TERM': 'linux', 09:02:00 INFO - 'TMOUT': '86400', 09:02:00 INFO - 'USER': 'cltbld', 09:02:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:00 INFO - '_': '/tools/buildbot/bin/python'} 09:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:00 INFO - Downloading/unpacking jsonschema 09: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 09: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 09: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 09: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 09: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 09: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 09:02:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:02:02 INFO - Downloading/unpacking functools32 (from jsonschema) 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:02:02 INFO - warning: no files found matching '*.txt' 09:02:02 INFO - no previously-included directories found matching 'build' 09:02:02 INFO - no previously-included directories found matching 'dist' 09:02:02 INFO - no previously-included directories found matching '.git*' 09:02:02 INFO - Installing collected packages: jsonschema, functools32 09:02:02 INFO - Running setup.py install for functools32 09:02:02 INFO - warning: no files found matching '*.txt' 09:02:02 INFO - no previously-included directories found matching 'build' 09:02:02 INFO - no previously-included directories found matching 'dist' 09:02:02 INFO - no previously-included directories found matching '.git*' 09:02:02 INFO - Successfully installed jsonschema functools32 09:02:02 INFO - Cleaning up... 09:02:02 INFO - Return code: 0 09:02:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:02 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 0x7f94b75b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, '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-1460646420.773127-1544315099', '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 09:02:02 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 09:02:02 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 09:02:02 INFO - Using env: {'DISPLAY': ':0', 09:02:02 INFO - 'HOME': '/home/cltbld', 09:02:02 INFO - 'LANG': 'en_US.UTF-8', 09:02:02 INFO - 'LANGUAGE': 'en_US:en', 09:02:02 INFO - 'LOGNAME': 'cltbld', 09:02:02 INFO - 'MAIL': '/var/mail/cltbld', 09:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:02 INFO - 'MOZ_NO_REMOTE': '1', 09:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:02 INFO - 'NO_EM_RESTART': '1', 09:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:02 INFO - 'PWD': '/builds/slave/test', 09:02:02 INFO - 'SHELL': '/bin/bash', 09:02:02 INFO - 'SHLVL': '1', 09:02:02 INFO - 'TERM': 'linux', 09:02:02 INFO - 'TMOUT': '86400', 09:02:02 INFO - 'USER': 'cltbld', 09:02:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:02 INFO - '_': '/tools/buildbot/bin/python'} 09:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:02 INFO - Downloading/unpacking flake8 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:02:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:02:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09: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 09: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 09: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 09: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 09: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 09: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 09:02:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09: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 09: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 09: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 09: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 09: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 09: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 09:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:05 INFO - no previously-included directories found matching 'docs/_build' 09:02:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:02:05 INFO - Running setup.py install for pep8 09:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:05 INFO - no previously-included directories found matching 'docs/_build' 09:02:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:02:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:02:05 INFO - Cleaning up... 09:02:05 INFO - Return code: 0 09:02:05 INFO - Running post-action listener: _resource_record_post_action 09:02:05 INFO - Running post-action listener: _start_resource_monitoring 09:02:05 INFO - Starting resource monitoring. 09:02:05 INFO - ##### 09:02:05 INFO - ##### Running install step. 09:02:05 INFO - ##### 09:02:05 INFO - Running pre-action listener: _resource_record_pre_action 09:02:05 INFO - Running main action method: install 09:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:06 INFO - Reading from file tmpfile_stdout 09:02:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:02:06 INFO - Reading from file tmpfile_stdout 09:02:06 INFO - Output received: 09:02:06 INFO - Usage: mozinstall [options] installer 09:02:06 INFO - Options: 09:02:06 INFO - -h, --help show this help message and exit 09:02:06 INFO - -d DEST, --destination=DEST 09:02:06 INFO - Directory to install application into. [default: 09:02:06 INFO - "/builds/slave/test"] 09:02:06 INFO - --app=APP Application being installed. [default: firefox] 09:02:06 INFO - mkdir: /builds/slave/test/build/application 09:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:02:21 INFO - Reading from file tmpfile_stdout 09:02:21 INFO - Output received: 09:02:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:02:21 INFO - Running post-action listener: _resource_record_post_action 09:02:21 INFO - ##### 09:02:21 INFO - ##### Running run-tests step. 09:02:21 INFO - ##### 09:02:21 INFO - Running pre-action listener: _resource_record_pre_action 09:02:21 INFO - Running main action method: run_tests 09:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:02:21 INFO - Python 2.7.3 09:02:21 INFO - Return code: 0 09:02:21 INFO - grabbing minidump binary from tooltool 09:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:21 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a37410>, '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 0x2a38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a387a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:02:21 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 09:02:21 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 09:02:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:21 INFO - Return code: 0 09:02:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:02:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:02:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:02:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:02:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:02:22 INFO - Return code: 0 09:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.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 09:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.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 09:02:22 INFO - Using env: {'DISPLAY': ':0', 09:02:22 INFO - 'HOME': '/home/cltbld', 09:02:22 INFO - 'LANG': 'en_US.UTF-8', 09:02:22 INFO - 'LANGUAGE': 'en_US:en', 09:02:22 INFO - 'LOGNAME': 'cltbld', 09:02:22 INFO - 'MAIL': '/var/mail/cltbld', 09:02:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:02:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:22 INFO - 'MOZ_NO_REMOTE': '1', 09:02:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:22 INFO - 'NO_EM_RESTART': '1', 09:02:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:22 INFO - 'PWD': '/builds/slave/test', 09:02:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:02:22 INFO - 'SHELL': '/bin/bash', 09:02:22 INFO - 'SHLVL': '1', 09:02:22 INFO - 'TERM': 'linux', 09:02:22 INFO - 'TMOUT': '86400', 09:02:22 INFO - 'USER': 'cltbld', 09:02:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460646420.773127-1544315099', 09:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:22 INFO - '_': '/tools/buildbot/bin/python'} 09:02:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.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 09:02:23 INFO - mozversion application_buildid: 20160414074538 09:02:23 INFO - mozversion application_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 09:02:23 INFO - mozversion application_display_name: Nightly 09:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:23 INFO - mozversion application_name: Firefox 09:02:23 INFO - mozversion application_remotingname: firefox 09:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:02:23 INFO - mozversion application_vendor: Mozilla 09:02:23 INFO - mozversion application_version: 48.0a1 09:02:23 INFO - mozversion platform_buildid: 20160414074538 09:02:23 INFO - mozversion platform_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 09:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:02:23 INFO - mozversion platform_version: 48.0a1 09:02:23 INFO - using testdate: 1460649743 09:02:23 INFO - actual date: 1460649743 09:02:23 INFO - starting webserver on 'localhost:50300' 09:02:23 INFO - SUITE-START | Running 2 tests 09:02:23 INFO - TEST-START | dromaeo_css 09:02:23 INFO - operating with platform_type : linux_ 09:02:23 INFO - Initialising browser for dromaeo_css test... 09:02:23 INFO - TEST-INFO | started process 1539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfxPcAP/profile http://localhost:50300/getInfo.html) 09:02:27 INFO - PROCESS | 1539 | __metrics Screen width/height:1600/1200 09:02:27 INFO - PROCESS | 1539 | colorDepth:24 09:02:27 INFO - PROCESS | 1539 | Browser inner width/height: 1024/697 09:02:27 INFO - PROCESS | 1539 | __metrics 09:02:28 ERROR - PROCESS | 1539 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:02:29 INFO - TEST-INFO | 1539: exit 0 09:02:29 INFO - Browser initialized. 09:02:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:29 INFO - TEST-INFO | started process 1621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfxPcAP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:41 INFO - PROCESS | 1621 | RSS: Main: 154677248 09:02:41 INFO - PROCESS | 1621 | 09:03:33 INFO - PROCESS | 1621 | 1460649813045 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] 09:05:44 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50300/tests/dromaeo/cssquery-ext.html) 09:05:45 INFO - PROCESS | 1621 | RSS: Main: 273182720 09:05:45 INFO - PROCESS | 1621 | 09:08:48 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-ext.html (next: http://localhost:50300/tests/dromaeo/cssquery-jquery.html) 09:08:49 INFO - PROCESS | 1621 | RSS: Main: 237355008 09:08:49 INFO - PROCESS | 1621 | 09:11:51 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50300/tests/dromaeo/cssquery-mootools.html) 09:11:51 INFO - PROCESS | 1621 | RSS: Main: 247320576 09:11:51 INFO - PROCESS | 1621 | 09:14:53 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50300/tests/dromaeo/cssquery-prototype.html) 09:14:54 INFO - PROCESS | 1621 | RSS: Main: 234291200 09:14:54 INFO - PROCESS | 1621 | 09:17:57 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50300/tests/dromaeo/cssquery-yui.html) 09:17:57 INFO - PROCESS | 1621 | RSS: Main: 215052288 09:17:57 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | Cycle 1(1): loaded http://localhost:50300/tests/dromaeo/cssquery-yui.html (next: http://localhost:50300/tests/dromaeo/cssquery-dojo.html) 09:21:00 INFO - PROCESS | 1621 | RSS: Main: 267919360 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | __start_tp_report 09:21:00 INFO - PROCESS | 1621 | _x_x_mozilla_page_load 09:21:00 INFO - PROCESS | 1621 | _x_x_mozilla_page_load_details 09:21:00 INFO - PROCESS | 1621 | |i|pagename|runs| 09:21:00 INFO - PROCESS | 1621 | |0;dojo.html;2636.275024368299;2678.223315238581;2703.5809449535327;2718.537848565744;2726.9863650681746;4513.932291015637;4589.747563883985;4670.206064968955;4688.648351373644;4725.220338644124;4651.953480465194;4660.091282199973;4677.181493238678;4729.12511185431;4734.218853889112;4226.070264541796;4297.634701050414;4341.305391137419;4371.1913296040175;4440.289553671413;4368.716033457831;4396.054848207635;4411.09572537629;4425.7565833879125;4452.3544086107495;4205.390218418327;4222.451081359403;4295.312749960022;4307.504636966758;4316.503602085769;4200.558941311179;4265.019045619525;4269.402283680287;4277.059047009653;4312.956870431287;4247.617714405718;4284.078923031532;4289.914201715979;4295.935560966556;4324.437823083011;4422.314541246112;4515.63874890008;4542.136993971135;4591.265397536378;4616.169089563878;4960.578350840183;4960.90078198434;4968.354113965162;4984.725840078794;4997.950020499785;4989.775460104268;4996.1756310208775;4998.950010499885;4999.0501804657;5027.723475208862;4489.326601009875;4594.517575654575;4651.093036857848;4684.063187362541;4695.882602934954;4987.975060124676;5000.599952003831;5002.024605202024;5004.924926126111;5048.192289233779;4815.662903596714;4817.975910120427;4819.325294458778;4829.082474329866;4850.878728031827;4927.655064145547;4943.826966056171;4976.701397916137;5015.272785446163;5034.672746271481;4957.231629097496;4962.900741985212;4972.477889821516;4984.40187177541;5031.572316353151;4820.927686084711;4956.207006878954;4960.578350840146;4969.130402179604;5011.373578302712;4176.331786914079;4187.895302617398;4256.531781504032;4263.147370525907;4265.274903266452;3657.74395792292;3688.0964163780045;3688.280785246851;3723.1622884851236;3725.3480640887738;4328.415663885398;4348.5216626171095;4348.67384946124;4350.825966961349;4389.012472193731;4828.420589529279;5038.395392552917;5073.898522029539;5102.209157580581;5118.104331742004;4327.82688692455;4328.3723860040745;4348.934765978513;4349.630281426114;4391.956080439155;4366.694331396835;4508.211063063951;4509.594136527663;4518.299663552155;4544.750038747835;4656.231721765938;4701.717896926195;4707.199776038014;4745.169595320874;4747.62019038483;4961.531169232843;4998.775055122601;5001.24981252815;5002.199648056294;5047.318611987334;4589.311603259538;4704.647151463585;4712.410948631421;4730.077634861169;4761.595264402565;4894.19245824435;4916.950830491649;4917.680350777188;4937.703737775745;4967.453580106113;4953.702777833341;4976.576990955809;4977.104121258063;4983;5002;4711.316859055486;4804.975975120102;4838.346823178826;4885.096257192431;4888.193448081027;4851.708897466164;4866.95133048665;4870.09903167915;4897.877553061202;4905.117078925685;4791.520847915181;4808.471068182567;4812.06164797861;4818.253170758538;4866.586340161126;4741.383620129361;4790.568848803624;4882.584980276716;4909.140900342497;4940.6788558743565;4676.251799712029;4799.9760001199775;4830.903381932412;4834.758262086812;4861.951380486292 09:21:00 INFO - PROCESS | 1621 | |1;ext.html;551.2200236665119;597.8027251007171;597.9491743201828;609.591573645658;616.1712496691949;26480;26706.465870682576;26873.0594429195;26889.19332420028;33679.15802104949;34663.82668086662;35055;35088.64911350886;35154.64845351546;36809;7573.242675732437;7804.960975195145;7817.8827317590285;7828.725994590191;7831.334336581397;7477.252274772506;7641.3886889048745;7791.532508049507;9538.475383853885;9736.464494452803;9779.21766258701;9950.701478955643;9957.352772069793;9963.402195868235;9974;9702.320837541374;9819.116279534805;9842.4586647734;9847.261455390875;9851.162651174658;9639.277054220962;9751.317407781458;9754.609815607368;9762.219022478255;9767.365121267096;29934.401311973637;38188.04529886747;38436.23127537434;38714.03214919649;38749.61250387488;2263.779061228159;2366.562185995579;2490.8256422050463;2581.328854497844;3030.7878448508613;22466.502925377863;28629.427411451863;28680.569791453145;28938.71061289402;29361.853190734124;3472.2187507810795;3486.4421692529327;3520.2959408118477;3597.478365636994;3605.549306336708;196747;198319;199022;200058;200454;53228;53948.73025634847;53974.46025539773;53998.19002714963;54083.45916540784;56197;60165.38180800108;60267.39732602706;60461.39538604645;60568;14610.342534585969;14770.704585908437;14783.334749936279;14793.334299956528;14795.334209960578;10193.592256309812;11715.88284117165;11924.582639607746;11949.522019119138;11950.521979120911;18558.907205463885;18896.90551547261;19066.90466547686;19185.136668849937;19240;6930.792076237721;7045.330693584101;7179.676914538858;7234.782956511313;7285.963570182221;891.9910800891907;960.1358777100666;962.5476026267643;991.6083147156833;993.7962717642865;24862;26658;26728.198154055408;27575.255178474865;28138.577921330787;999.415342024909;1001.6627801884566;1052.9832031230621;1069.027185261424;1074.5003573338436;14235.288235588387;14730.189839558927;14736.115833050051;14793.334299956528;15154.242287885561;339078;344363;344789;344922;347268;47382;48895.26657100146;49009.26486102711;49010;49032.264516032286;1068.8877667844765;1171.6367925942814;1238.5107882386587;1279.302779984929;1330.9201447913156;25447.36381590475;27457.862710687117;27570.10513896012;27804.443911122067;28044.29889252785;38786.4182037264;39244.80377598094;39293.803530982164;39304;39343;184170;185192;185760;185888;186198;32248.516272255467;32305.35389292248;38781.41827872641;41198.1760364785;41837.58162418459;35336.293274134885;42725.57274427216;43824.12351753011;44393.778031109636;44572.77713611411;32381.83809081034;33931.3213735719;34579.65420345764;34877.47683784796;35145.47281790724;33566;34309.142271443416;34405;34497.482537761454;34652;34116.658833412344;34597.30805383928;34639.88533662383;34830.12924676802;34934.47598285977;30060.69939300579;30212.84893575606;30696.232594185323;30997;31032.53451198189;23426.64860027067;23826.761732383147;24025.16665418293;24414.26757197287;24448.755512444648 09:21:00 INFO - PROCESS | 1621 | |2;jquery.html;382.47011952191224;386.6249737754378;388.2603640065676;399.1697269679068;400.5433805461772;13592.592222233325;14150.858491415083;15516.612084697888;17555.2100155493;18068.09659517024;16082.115483648395;16193.190340482988;16856.831431685678;17508.82491175088;17559;4566.817327306904;5156.845294641157;5313.574914006889;5340.25236466895;5353.892922141555;3739.289534988357;5276.525112739852;5749.885002299951;6057.091436284549;6062.757489700407;6015.608985415934;6023.216981792383;6034.487068599175;6048.939510604903;6054.243219597551;5966.045432730764;6057.030875059969;6057.606255593372;6060.848478788022;6065.818025459222;5171.870703232449;5187.221916712523;5370.060239458118;5370.409254981949;5462.6995515246645;11648.825267620992;12330.260184388966;20481.5903681927;20645.793542064537;20660.276890308767;1907.4754442528276;1933.01416277698;1978.4361456984834;2182.1380554680973;2204.393791707277;8789.165029322205;9129.680461183892;9294.024127466586;9440.197583205436;9720.659776907845;1616.5554472520034;1663.717168081429;1705.914704264782;1767.2312544043255;1776.6180271241744;68320.31679683189;70759.64620176918;71795.28204717938;74013;76195.38046195336;10235.948820255851;10250.231232657581;10331.48342582868;10377.377357358582;10479.84280235797;14397.208153551655;14551.563453096423;14556.854431455762;14579.92710036443;14609.488667896572;7343.742968996059;7561.3194812467145;7633.923660763321;7718.652660630285;7736;6813.625250611165;6977.406920411822;6993.405560527311;7057.435405167575;7256.0567126273245;4403.867883963422;4450.532694067141;4497.257952437811;4559.635229181657;4561.931571026437;1746.1182103038138;1782.295993082725;1799.73004049391;1815.2285278756476;1838.1268897273687;775.7323723315448;890.1143362354369;905.3029167540957;921.9078092190728;967.6322997260996;15713.21433928299;15868.365265389486;16662.250198741087;16841.894763154607;17072;843.1610547505271;874.8643960186181;888.1562515610196;922.4327038871046;938.5588773276686;8999.865002024975;9197.81604367909;9220;9235.307351948632;9378.577963991636;398458;398914;402994;406919;415868;78103;82812;84596;85411.5729421349;85667.57166214254;961.1541843177959;983.2379905573094;985.2364417576435;993.9503024848873;1011.9898801012043;14444.277786110863;14491.637709057359;14510.201938893462;15683.529494115195;15700.214989250264;31726.365472689955;32232.83883580567;33839;33845.83077084599;33930.66069339275;48702.75648621734;50493.49506504888;51666;51692.48307516877;52226.73886630694;7527.8118047049265;7631.771046868603;7676.117246516722;7723.1118421380015;7733.613319333898;8181.509109453452;11038.779224415628;11397.715057123638;11639.59261425846;11663.416829158678;9649.951750241204;10391.403917516507;10431.478426078818;10487;10535.15718742514;9821.214302855897;9952.353097048668;10102.242331824995;10141.239407044648;10184.898151018395;9733.318667693193;10175.135113515435;10304.381737095799;10331.690049298533;10395.740106497398;7397.889031664422;7433.665485053294;7447.925520744723;7544.698212071456;7547.886781698388;8860.158284962918;9929.255305851946;9939.055789699967;10002.099811017044;10056.29605927578 09:21:00 INFO - PROCESS | 1621 | |3;mootools.html;1277.0166971432004;1298.6233992142277;1380.0339762166484;1392.3734319556202;1636.6808472347898;6733.898991515125;7556.055493063367;7754.37964962803;7758.456908016441;7760.883586746203;7484.288992545713;7646.96176519118;7665.1951545087795;7666.769996900102;7667.501612395205;1910.4173227165709;1973.2205778717398;2175.932863779408;2211.568744094898;2246.7079279693617;2225.6550234713645;2241.4508445430893;2244.16965722682;2253.4479052632046;2256;2160.049578185601;2167.4147980045377;2195.1877805212016;2197.549502352022;2197.8351623628214;1880.7178923161566;2092.8953552322323;2126.617208902397;2160.481484443738;2161.146347192866;2166.2959538150008;2170.4899348653053;2180.803727664502;2193.429708275844;2197.9560408791895;7731.188225236382;7769.339606133485;7815.335696465807;7817;7839.568823714693;4443.800028998703;4625.236835922069;4631.374764406795;4637.536246375369;4653.0693861227555;3008.473517134493;3048.908532743999;3080.3993221321853;3091;3141.921451963696;1020.8009438159562;1030.2118879057527;1047.3454091193005;1703.429351167348;1724.4912750738438;10228.38629682214;10236;10268;10375.896241037568;10379;3911.8435262589746;3998.3202855514633;4057.208844275338;4136.627703506699;4138.544760076389;8120.390970677223;8182.631781569725;8184.2224988625985;8194.590270486451;8195.549244791593;4475.239209334421;4484;4492.146492166478;4501.954980450154;4504.369388285642;3770.830312635938;4150.750954942653;4203.894902627459;4219.725717828393;4224.5003023926065;3447.844846981842;3463.6363181866045;3570.91072723184;3591.676749092594;3603.4774957631;1068.4390694885246;1100.818364969771;1103.668899330214;1114.3091283404342;1122.6070875193616;794.7417089445837;893.660409044559;915.9878334440348;922.6078916460477;937.6765016069445;5378.865528361744;5511.311086114236;5572.108462646038;5627.662340259598;5666.03677374839;414.50673698298925;419.27256210474803;426.9135051294463;432.08613781851784;433.3348310343607;3810.3522401191863;3846.7307288489537;3867.16855875988;3931.8820435386983;4047.8583249586122;9429.198518126037;9632.95183524092;9644.517774111408;9771.9022809771;9776.266779991529;9499.90500095004;9720.07659272382;9759.219262458986;9762.951185244028;9768.90231097694;6807.353301436356;6839.931600684128;7005.1944026436595;7014.298570142945;7024.473164512682;5482.39693633708;5588.38527761954;5611.130274807411;5647.435256474319;5743.971280143573;8841.204291613785;8926.152015558511;8982.685606003759;9030.096990300917;9094.226990705863;8928.955355223183;8983.685571004984;9059.728208153765;9205.723828285161;9211.723648290563;6193.38066193377;6504.934950650433;6770.322967703387;6789.93210067893;6894.207166175954;7360.374368178551;7380.741674041383;7444.702211911463;7453.515521491086;7456.701731930662;6520.18497687789;6549.541532092899;6581.835454113685;6603.042558828847;6825.180978282638;6692.765753198614;6702.597844129368;6746.392824645805;6787.626680532618;6831.658417079226;6424.710888010144;6449.96775016122;6511.2512061113575;6515.54391192612;6518;4819.397575303087;4824.758762061953;4915.582175515121;4921.483244259444;4957.851264462072;4671.883202919954;4694.7887345068875;4707.788149533348;4832.34763306949;4841.080194762983 09:21:00 INFO - PROCESS | 1621 | |4;prototype.html;316.4084654189427;320.2458210913299;320.74340527577937;321.2899492122409;327.2326394604651;5040.269160971657;5108.616853735971;5119.564836988856;5129.589632829374;5146.279520867072;5055.494450554943;5057.696538207711;5081.16160833463;5085.135526960416;5095.363079615048;3783.6405541473514;3834.6357096075826;3951.723379363446;3994.7802870842092;4038.232735780207;3964.5837187095226;3991.560928297885;4002.919941601166;4027.879163625081;4030.7380020298588;3739.775613463201;3975.5030621172355;3988.621080997315;3992.3412636914873;3994.4407782910416;3874.4769456123486;3981.960180398217;3993.1614360983936;4005.299072662287;4022.2357752027315;3518.876839310612;3547.7871327720163;3556.8577256909693;3557.7509574329806;3572.374834403969;4822;4858.149823780825;4860.756962151913;4880.902381952376;4882.194437917739;4359.629431498326;4583.014651849869;4600.102979918917;4604.263317869125;4608.884777880547;5271.789128434858;5282.339707536558;5288.788448462057;5296.470352964711;5327.946720532823;3893.1824316893485;3893.552241492208;3894.123822140024;3900.9219815603815;3904.4533765272886;5468.179773034037;5523.972380138114;5553.222548843165;5584.246126772915;5584.329880414376;3973.7218394712095;3992.6606238470054;3994.800259986989;3996.1208534122447;4008.158286759755;4058.2492238935893;4062.979685101556;4063.6139566741113;4064.1058967027207;4072.735272207297;4411.338299255138;4573.794179261941;4574.879154607076;4585.679002469862;4587.9541204588195;5325.254464374991;5325.4940780625775;5331.306930099062;5337.466253374631;5339;1374.8900087992936;1402.7965944937928;1407.4370251899322;1413.0814970269203;1417.362187015847;903.4850135422746;955.9330846840794;979.1872745621259;996.3673067602125;1005.5977608956476;4703.976480117578;4708.929366059512;4722.504137065559;4729.456112547101;4733.644976626698;5469.781208751685;5469.945300547023;5475.233467314579;5485.643433176911;5486.451354864482;4569.405977223007;4646.395968524071;4662.246891252575;4713.67004309695;4843.854684359404;2951.6900725423952;2965.4365670522534;2976.300569366197;2987.9691506430245;2988.5666578346454;5241.580673546107;5244.9737751310995;5251.396089449686;5258.868528286824;5260.421353651095;5484.506394424521;5670;5679.683440585102;5682.857928551819;5708.686022268732;5210.322658054429;5229.843104706865;5230.137027390438;5232.215167724872;5233.895322093536;5436.53789427903;5549.38956714753;5563.193336966198;5575.386707462257;5578.888422231452;5433.5924805640525;5453.972730136324;5458.399576046552;5466.91799622998;5477.890442191214;5209.869753256199;5214.947850521598;5247.7113758743635;5251.606129540223;5253.185756207794;3769.981150094232;3852.9229415410973;3880.844766209433;3884.6503814656817;3889.669378102893;5512.310961129859;5523.420040895809;5533.146395957399;5539.972300138474;5545.306836645419;5330.173823057432;5346.572274217975;5351.892962140813;5366.517013468807;5367.6779393234965;5131.230315452712;5320.477594045031;5321.627486075938;5335.519803217729;5360.43715409892;5069.5944324454695;5275.287836142072;5293.417724050274;5295.126304159925;5317.468253174651;5223.921641175461;5309.309789727466;5323.0684630190335;5325.174597937326;5334.11987022137;5271.393789714232;5286.735663216747;5291.100512912737;5297.788088476418;5319.41486436484 09:21:00 INFO - PROCESS | 1621 | |5;yui.html;625.937406259374;683.1699485125572;707.003125592914;719.74089327842;761.5392687424112;11181.105511559075;11234.887651123476;11292.548298068068;11860.466279017453;12605.180663256904;12612.180208286454;12750.553730619431;12790.744185116291;12796.360181990909;12797.936010319936;640.5292110298926;802.1377019703828;811.7077851973285;817.3297895725508;818.30444122496;782.86299897518;807.096052421289;811.8701007838747;812.0620683111016;812.3704129299781;838.9454685445457;842.3177226446597;843.5782108945527;843.633019636457;843.6583183810567;651.8240075179723;831.5135645647304;839.4543546694637;839.5676226743202;841.8021764885247;610.697704636208;614.6373639552685;617.9412955769195;618.0173524096708;618.9319174890759;12192.329421881794;12242.204256723284;12245.448954796966;12252.877471225263;12258.1419300649;11970.281783092954;12516.81224781629;13105.14816536922;13105.868941310655;13390;9708.805823883553;9749.951250243774;9826.557804898797;10213.2850700451;10231.23265755064;4203.159368126387;4207.789610519461;4254.872353829359;4328.805203765838;4436.866893993185;40509.59490405088;40620.59379406198;41411.7929410351;41565.1686966262;41928.58071419277;9639.325247232766;9820.754481138028;9868.161206297402;9891.60433582663;10056.597736090474;17344.13279336028;18538.814611853708;18557.44327670172;18573.628527429646;18588.907055464635;6656.900146497709;6751.932480675228;6848.863022739517;6894.379505844498;6976.825579360557;3732.9066773330883;3776.188119554309;3839.673627741673;3856.82644281008;3926.155876486569;2973.4796410628055;3077.646070701853;3081.644076606286;3088.6139232595924;3096.829674367886;514.3673281863329;518.8234073356695;528.20241435432;529.3436139187456;543.4701166362764;455.71973236459337;542.8100164942239;609.8810731907324;624.0825985800956;635.3582881289931;7113.679884405215;7300.306470885257;7440.181580026193;7559.811004724816;7878.369730421553;617.7312868901952;628.1959092361693;635.732992143301;644.3427703742157;652.9444997175293;3470.5661792275964;3486.738494612914;3505.596856361551;3555.5911070227253;3634.454831775202;50275.24587131196;51027.23459148116;51343.7432812841;51433.48566514362;51622.74188629033;45204.321935171;45768.54231457709;46127;46273.76863115663;46319.76840115778;40821.591784082375;41082;41425;41606.375904361455;41751.1649767003;6886.242463501042;6948.409385202314;7031.859362812817;7070.964645176741;7187.281271872771;26664.20007399781;27263.182104536896;27357.179284621492;27575;27991.860040699667;34932.301353973286;36566.63433365632;37811.81094094512;37907.81046094752;38043.80978095092;9580.18568421692;9679.467629280458;9888.703338899844;9906.405615663083;10174.084332409822;10635.840462392916;10659.467026648792;10805.298675331167;10864.891351086388;10873.673789786319;9869.25980551476;10070.546825392728;10317.27779055459;10406.843897341394;10541.947290263499;8770.780730481789;8867.866981995405;9122.680706175252;9127.543622818965;9323.627054917728;9635.710928672152;9785.266105042008;9863.605455781688;9919.851202231828;10268.691939241835;7904.328132108835;8030.799230019296;8159.428839981382;8182.713605023796;8390.412671112963;7884.741583311863;8201.95899020501;8301.626426810928;8337.874931876147;8405.53769542681 09:21:00 INFO - PROCESS | 1621 | __end_tp_report 09:21:00 INFO - PROCESS | 1621 | __start_cc_report 09:21:00 INFO - PROCESS | 1621 | _x_x_mozilla_cycle_collect,1105 09:21:00 INFO - PROCESS | 1621 | __end_cc_report 09:21:00 INFO - PROCESS | 1621 | __startTimestamp1460650860963__endTimestamp 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | ------- Summary: start ------- 09:21:00 INFO - PROCESS | 1621 | Number of tests: 6 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#0] dojo.html Cycles:165 Average:4609.50 Median:4730.08 stddev:464.20 (9.8%) stddev-sans-first:439.06 09:21:00 INFO - PROCESS | 1621 | Values: 2636.3 2678.2 2703.6 2718.5 2727.0 4513.9 4589.7 4670.2 4688.6 4725.2 4652.0 4660.1 4677.2 4729.1 4734.2 4226.1 4297.6 4341.3 4371.2 4440.3 4368.7 4396.1 4411.1 4425.8 4452.4 4205.4 4222.5 4295.3 4307.5 4316.5 4200.6 4265.0 4269.4 4277.1 4313.0 4247.6 4284.1 4289.9 4295.9 4324.4 4422.3 4515.6 4542.1 4591.3 4616.2 4960.6 4960.9 4968.4 4984.7 4998.0 4989.8 4996.2 4999.0 4999.1 5027.7 4489.3 4594.5 4651.1 4684.1 4695.9 4988.0 5000.6 5002.0 5004.9 5048.2 4815.7 4818.0 4819.3 4829.1 4850.9 4927.7 4943.8 4976.7 5015.3 5034.7 4957.2 4962.9 4972.5 4984.4 5031.6 4820.9 4956.2 4960.6 4969.1 5011.4 4176.3 4187.9 4256.5 4263.1 4265.3 3657.7 3688.1 3688.3 3723.2 3725.3 4328.4 4348.5 4348.7 4350.8 4389.0 4828.4 5038.4 5073.9 5102.2 5118.1 4327.8 4328.4 4348.9 4349.6 4392.0 4366.7 4508.2 4509.6 4518.3 4544.8 4656.2 4701.7 4707.2 4745.2 4747.6 4961.5 4998.8 5001.2 5002.2 5047.3 4589.3 4704.6 4712.4 4730.1 4761.6 4894.2 4917.0 4917.7 4937.7 4967.5 4953.7 4976.6 4977.1 4983.0 5002.0 4711.3 4805.0 4838.3 4885.1 4888.2 4851.7 4867.0 4870.1 4897.9 4905.1 4791.5 4808.5 4812.1 4818.3 4866.6 4741.4 4790.6 4882.6 4909.1 4940.7 4676.3 4800.0 4830.9 4834.8 4862.0 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#1] ext.html Cycles:180 Average:40875.96 Median:34645.94 stddev:66410.57 (191.7%) stddev-sans-first:66527.85 09:21:00 INFO - PROCESS | 1621 | Values: 551.2 597.8 597.9 609.6 616.2 26480.0 26706.5 26873.1 26889.2 33679.2 34663.8 35055.0 35088.6 35154.6 36809.0 7573.2 7805.0 7817.9 7828.7 7831.3 7477.3 7641.4 7791.5 9538.5 9736.5 9779.2 9950.7 9957.4 9963.4 9974.0 9702.3 9819.1 9842.5 9847.3 9851.2 9639.3 9751.3 9754.6 9762.2 9767.4 29934.4 38188.0 38436.2 38714.0 38749.6 2263.8 2366.6 2490.8 2581.3 3030.8 22466.5 28629.4 28680.6 28938.7 29361.9 3472.2 3486.4 3520.3 3597.5 3605.5 196747.0 198319.0 199022.0 200058.0 200454.0 53228.0 53948.7 53974.5 53998.2 54083.5 56197.0 60165.4 60267.4 60461.4 60568.0 14610.3 14770.7 14783.3 14793.3 14795.3 10193.6 11715.9 11924.6 11949.5 11950.5 18558.9 18896.9 19066.9 19185.1 19240.0 6930.8 7045.3 7179.7 7234.8 7286.0 892.0 960.1 962.5 991.6 993.8 24862.0 26658.0 26728.2 27575.3 28138.6 999.4 1001.7 1053.0 1069.0 1074.5 14235.3 14730.2 14736.1 14793.3 15154.2 339078.0 344363.0 344789.0 344922.0 347268.0 47382.0 48895.3 49009.3 49010.0 49032.3 1068.9 1171.6 1238.5 1279.3 1330.9 25447.4 27457.9 27570.1 27804.4 28044.3 38786.4 39244.8 39293.8 39304.0 39343.0 184170.0 185192.0 185760.0 185888.0 186198.0 32248.5 32305.4 38781.4 41198.2 41837.6 35336.3 42725.6 43824.1 44393.8 44572.8 32381.8 33931.3 34579.7 34877.5 35145.5 33566.0 34309.1 34405.0 34497.5 34652.0 34116.7 34597.3 34639.9 34830.1 34934.5 30060.7 30212.8 30696.2 30997.0 31032.5 23426.6 23826.8 24025.2 24414.3 24448.8 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#2] jquery.html Cycles:180 Average:24741.50 Median:49598.13 stddev:66929.06 (134.9%) stddev-sans-first:67091.82 09:21:00 INFO - PROCESS | 1621 | Values: 382.5 386.6 388.3 399.2 400.5 13592.6 14150.9 15516.6 17555.2 18068.1 16082.1 16193.2 16856.8 17508.8 17559.0 4566.8 5156.8 5313.6 5340.3 5353.9 3739.3 5276.5 5749.9 6057.1 6062.8 6015.6 6023.2 6034.5 6048.9 6054.2 5966.0 6057.0 6057.6 6060.8 6065.8 5171.9 5187.2 5370.1 5370.4 5462.7 11648.8 12330.3 20481.6 20645.8 20660.3 1907.5 1933.0 1978.4 2182.1 2204.4 8789.2 9129.7 9294.0 9440.2 9720.7 1616.6 1663.7 1705.9 1767.2 1776.6 68320.3 70759.6 71795.3 74013.0 76195.4 10235.9 10250.2 10331.5 10377.4 10479.8 14397.2 14551.6 14556.9 14579.9 14609.5 7343.7 7561.3 7633.9 7718.7 7736.0 6813.6 6977.4 6993.4 7057.4 7256.1 4403.9 4450.5 4497.3 4559.6 4561.9 1746.1 1782.3 1799.7 1815.2 1838.1 775.7 890.1 905.3 921.9 967.6 15713.2 15868.4 16662.3 16841.9 17072.0 843.2 874.9 888.2 922.4 938.6 8999.9 9197.8 9220.0 9235.3 9378.6 398458.0 398914.0 402994.0 406919.0 415868.0 78103.0 82812.0 84596.0 85411.6 85667.6 961.2 983.2 985.2 994.0 1012.0 14444.3 14491.6 14510.2 15683.5 15700.2 31726.4 32232.8 33839.0 33845.8 33930.7 48702.8 50493.5 51666.0 51692.5 52226.7 7527.8 7631.8 7676.1 7723.1 7733.6 8181.5 11038.8 11397.7 11639.6 11663.4 9650.0 10391.4 10431.5 10487.0 10535.2 9821.2 9952.4 10102.2 10141.2 10184.9 9733.3 10175.1 10304.4 10331.7 10395.7 7397.9 7433.7 7447.9 7544.7 7547.9 8860.2 9929.3 9939.1 10002.1 10056.3 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#3] mootools.html Cycles:180 Average:5114.95 Median:4836.71 stddev:2823.87 (58.4%) stddev-sans-first:2817.06 09:21:00 INFO - PROCESS | 1621 | Values: 1277.0 1298.6 1380.0 1392.4 1636.7 6733.9 7556.1 7754.4 7758.5 7760.9 7484.3 7647.0 7665.2 7666.8 7667.5 1910.4 1973.2 2175.9 2211.6 2246.7 2225.7 2241.5 2244.2 2253.4 2256.0 2160.0 2167.4 2195.2 2197.5 2197.8 1880.7 2092.9 2126.6 2160.5 2161.1 2166.3 2170.5 2180.8 2193.4 2198.0 7731.2 7769.3 7815.3 7817.0 7839.6 4443.8 4625.2 4631.4 4637.5 4653.1 3008.5 3048.9 3080.4 3091.0 3141.9 1020.8 1030.2 1047.3 1703.4 1724.5 10228.4 10236.0 10268.0 10375.9 10379.0 3911.8 3998.3 4057.2 4136.6 4138.5 8120.4 8182.6 8184.2 8194.6 8195.5 4475.2 4484.0 4492.1 4502.0 4504.4 3770.8 4150.8 4203.9 4219.7 4224.5 3447.8 3463.6 3570.9 3591.7 3603.5 1068.4 1100.8 1103.7 1114.3 1122.6 794.7 893.7 916.0 922.6 937.7 5378.9 5511.3 5572.1 5627.7 5666.0 414.5 419.3 426.9 432.1 433.3 3810.4 3846.7 3867.2 3931.9 4047.9 9429.2 9633.0 9644.5 9771.9 9776.3 9499.9 9720.1 9759.2 9763.0 9768.9 6807.4 6839.9 7005.2 7014.3 7024.5 5482.4 5588.4 5611.1 5647.4 5744.0 8841.2 8926.2 8982.7 9030.1 9094.2 8929.0 8983.7 9059.7 9205.7 9211.7 6193.4 6504.9 6770.3 6789.9 6894.2 7360.4 7380.7 7444.7 7453.5 7456.7 6520.2 6549.5 6581.8 6603.0 6825.2 6692.8 6702.6 6746.4 6787.6 6831.7 6424.7 6450.0 6511.3 6515.5 6518.0 4819.4 4824.8 4915.6 4921.5 4957.9 4671.9 4694.8 4707.8 4832.3 4841.1 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#4] prototype.html Cycles:180 Average:4456.72 Median:5083.15 stddev:1280.02 (25.2%) stddev-sans-first:1245.32 09:21:00 INFO - PROCESS | 1621 | Values: 316.4 320.2 320.7 321.3 327.2 5040.3 5108.6 5119.6 5129.6 5146.3 5055.5 5057.7 5081.2 5085.1 5095.4 3783.6 3834.6 3951.7 3994.8 4038.2 3964.6 3991.6 4002.9 4027.9 4030.7 3739.8 3975.5 3988.6 3992.3 3994.4 3874.5 3982.0 3993.2 4005.3 4022.2 3518.9 3547.8 3556.9 3557.8 3572.4 4822.0 4858.1 4860.8 4880.9 4882.2 4359.6 4583.0 4600.1 4604.3 4608.9 5271.8 5282.3 5288.8 5296.5 5327.9 3893.2 3893.6 3894.1 3900.9 3904.5 5468.2 5524.0 5553.2 5584.2 5584.3 3973.7 3992.7 3994.8 3996.1 4008.2 4058.2 4063.0 4063.6 4064.1 4072.7 4411.3 4573.8 4574.9 4585.7 4588.0 5325.3 5325.5 5331.3 5337.5 5339.0 1374.9 1402.8 1407.4 1413.1 1417.4 903.5 955.9 979.2 996.4 1005.6 4704.0 4708.9 4722.5 4729.5 4733.6 5469.8 5469.9 5475.2 5485.6 5486.5 4569.4 4646.4 4662.2 4713.7 4843.9 2951.7 2965.4 2976.3 2988.0 2988.6 5241.6 5245.0 5251.4 5258.9 5260.4 5484.5 5670.0 5679.7 5682.9 5708.7 5210.3 5229.8 5230.1 5232.2 5233.9 5436.5 5549.4 5563.2 5575.4 5578.9 5433.6 5454.0 5458.4 5466.9 5477.9 5209.9 5214.9 5247.7 5251.6 5253.2 3770.0 3852.9 3880.8 3884.7 3889.7 5512.3 5523.4 5533.1 5540.0 5545.3 5330.2 5346.6 5351.9 5366.5 5367.7 5131.2 5320.5 5321.6 5335.5 5360.4 5069.6 5275.3 5293.4 5295.1 5317.5 5223.9 5309.3 5323.1 5325.2 5334.1 5271.4 5286.7 5291.1 5297.8 5319.4 09:21:00 INFO - PROCESS | 1621 | 09:21:00 INFO - PROCESS | 1621 | [#5] yui.html Cycles:180 Average:12223.74 Median:26070.78 stddev:13847.67 (53.1%) stddev-sans-first:13859.13 09:21:00 INFO - PROCESS | 1621 | Values: 625.9 683.2 707.0 719.7 761.5 11181.1 11234.9 11292.5 11860.5 12605.2 12612.2 12750.6 12790.7 12796.4 12797.9 640.5 802.1 811.7 817.3 818.3 782.9 807.1 811.9 812.1 812.4 838.9 842.3 843.6 843.6 843.7 651.8 831.5 839.5 839.6 841.8 610.7 614.6 617.9 618.0 618.9 12192.3 12242.2 12245.4 12252.9 12258.1 11970.3 12516.8 13105.1 13105.9 13390.0 9708.8 9750.0 9826.6 10213.3 10231.2 4203.2 4207.8 4254.9 4328.8 4436.9 40509.6 40620.6 41411.8 41565.2 41928.6 9639.3 9820.8 9868.2 9891.6 10056.6 17344.1 18538.8 18557.4 18573.6 18588.9 6656.9 6751.9 6848.9 6894.4 6976.8 3732.9 3776.2 3839.7 3856.8 3926.2 2973.5 3077.6 3081.6 3088.6 3096.8 514.4 518.8 528.2 529.3 543.5 455.7 542.8 609.9 624.1 635.4 7113.7 7300.3 7440.2 7559.8 7878.4 617.7 628.2 635.7 644.3 652.9 3470.6 3486.7 3505.6 3555.6 3634.5 50275.2 51027.2 51343.7 51433.5 51622.7 45204.3 45768.5 46127.0 46273.8 46319.8 40821.6 41082.0 41425.0 41606.4 41751.2 6886.2 6948.4 7031.9 7071.0 7187.3 26664.2 27263.2 27357.2 27575.0 27991.9 34932.3 36566.6 37811.8 37907.8 38043.8 9580.2 9679.5 9888.7 9906.4 10174.1 10635.8 10659.5 10805.3 10864.9 10873.7 9869.3 10070.5 10317.3 10406.8 10541.9 8770.8 8867.9 9122.7 9127.5 9323.6 9635.7 9785.3 9863.6 9919.9 10268.7 7904.3 8030.8 8159.4 8182.7 8390.4 7884.7 8202.0 8301.6 8337.9 8405.5 09:21:00 INFO - PROCESS | 1621 | -------- Summary: end -------- 09:21:00 INFO - PROCESS | 1621 | 09:21:01 INFO - TEST-INFO | 1621: exit 0 09:21:01 INFO - TEST-OK | dromaeo_css | took 1118659ms 09:21:01 INFO - TEST-START | kraken 09:21:01 INFO - operating with platform_type : linux_ 09:21:01 INFO - Initialising browser for kraken test... 09:21:01 INFO - TEST-INFO | started process 1801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHLoRl/profile http://localhost:50300/getInfo.html) 09:21:05 INFO - PROCESS | 1801 | __metrics Screen width/height:1600/1200 09:21:05 INFO - PROCESS | 1801 | colorDepth:24 09:21:05 INFO - PROCESS | 1801 | Browser inner width/height: 1024/697 09:21:05 INFO - PROCESS | 1801 | __metrics 09:21:06 ERROR - PROCESS | 1801 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:21:07 INFO - TEST-INFO | 1801: exit 0 09:21:07 INFO - Browser initialized. 09:21:07 INFO - Running cycle 1/1 for kraken test... 09:21:07 INFO - TEST-INFO | started process 1884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoHLoRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:19 INFO - PROCESS | 1884 | RSS: Main: 154185728 09:21:19 INFO - PROCESS | 1884 | 09:21:22 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50300/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:23 INFO - PROCESS | 1884 | RSS: Main: 209055744 09:21:23 INFO - PROCESS | 1884 | 09:21:25 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50300/tests/kraken/driver.html?testName=audio-dft) 09:21:26 INFO - PROCESS | 1884 | RSS: Main: 194768896 09:21:26 INFO - PROCESS | 1884 | 09:21:29 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50300/tests/kraken/driver.html?testName=audio-fft) 09:21:30 INFO - PROCESS | 1884 | RSS: Main: 265838592 09:21:30 INFO - PROCESS | 1884 | 09:21:32 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50300/tests/kraken/driver.html?testName=audio-oscillator) 09:21:32 INFO - PROCESS | 1884 | RSS: Main: 173436928 09:21:32 INFO - PROCESS | 1884 | 09:21:35 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:35 INFO - PROCESS | 1884 | RSS: Main: 177725440 09:21:35 INFO - PROCESS | 1884 | 09:21:38 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50300/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:39 INFO - PROCESS | 1884 | RSS: Main: 213721088 09:21:39 INFO - PROCESS | 1884 | 09:21:42 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50300/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:43 INFO - PROCESS | 1884 | RSS: Main: 215146496 09:21:43 INFO - PROCESS | 1884 | 09:21:46 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50300/tests/kraken/driver.html?testName=json-parse-financial) 09:21:47 INFO - PROCESS | 1884 | RSS: Main: 214757376 09:21:47 INFO - PROCESS | 1884 | 09:21:48 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:49 INFO - PROCESS | 1884 | RSS: Main: 203726848 09:21:49 INFO - PROCESS | 1884 | 09:21:51 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:51 INFO - PROCESS | 1884 | RSS: Main: 204910592 09:21:51 INFO - PROCESS | 1884 | 09:21:53 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:54 INFO - PROCESS | 1884 | RSS: Main: 217903104 09:21:54 INFO - PROCESS | 1884 | 09:21:57 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:58 INFO - PROCESS | 1884 | RSS: Main: 224989184 09:21:58 INFO - PROCESS | 1884 | 09:22:00 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:01 INFO - PROCESS | 1884 | RSS: Main: 218288128 09:22:01 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:50300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50300/tests/kraken/driver.html?testName=ai-astar) 09:22:03 INFO - PROCESS | 1884 | RSS: Main: 281485312 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | __start_tp_report 09:22:03 INFO - PROCESS | 1884 | _x_x_mozilla_page_load 09:22:03 INFO - PROCESS | 1884 | _x_x_mozilla_page_load_details 09:22:03 INFO - PROCESS | 1884 | |i|pagename|runs| 09:22:03 INFO - PROCESS | 1884 | |0;ai-astar;110;113;107;111;113;111;101;113;115;112 09:22:03 INFO - PROCESS | 1884 | |1;audio-beat-detection;166;132;159;185;134;163;158;132;186;133 09:22:03 INFO - PROCESS | 1884 | |2;audio-dft;161;162;160;161;161;161;161;162;164;161 09:22:03 INFO - PROCESS | 1884 | |3;audio-fft;74;74;106;117;74;73;73;128;104;73 09:22:03 INFO - PROCESS | 1884 | |4;audio-oscillator;94;96;140;94;94;95;145;93;94;146 09:22:03 INFO - PROCESS | 1884 | |5;imaging-gaussian-blur;119;117;117;117;117;118;118;117;117;118 09:22:03 INFO - PROCESS | 1884 | |6;imaging-darkroom;147;147;146;146;145;146;146;146;145;146 09:22:03 INFO - PROCESS | 1884 | |7;imaging-desaturate;95;95;96;96;95;95;96;95;96;95 09:22:03 INFO - PROCESS | 1884 | |8;json-parse-financial;65;66;65;69;64;66;65;84;64;63 09:22:03 INFO - PROCESS | 1884 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;66;65 09:22:03 INFO - PROCESS | 1884 | |10;stanford-crypto-aes;83;84;84;83;85;83;84;85;87;85 09:22:03 INFO - PROCESS | 1884 | |11;stanford-crypto-ccm;141;148;147;145;137;135;138;136;171;138 09:22:03 INFO - PROCESS | 1884 | |12;stanford-crypto-pbkdf2;178;172;170;171;173;172;168;172;171;170 09:22:03 INFO - PROCESS | 1884 | |13;stanford-crypto-sha256-iterative;72;73;73;73;73;73;72;71;73;73 09:22:03 INFO - PROCESS | 1884 | __end_tp_report 09:22:03 INFO - PROCESS | 1884 | __start_cc_report 09:22:03 INFO - PROCESS | 1884 | _x_x_mozilla_cycle_collect,1885 09:22:03 INFO - PROCESS | 1884 | __end_cc_report 09:22:03 INFO - PROCESS | 1884 | __startTimestamp1460650923628__endTimestamp 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | ------- Summary: start ------- 09:22:03 INFO - PROCESS | 1884 | Number of tests: 14 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 09:22:03 INFO - PROCESS | 1884 | Values: 110.0 113.0 107.0 111.0 113.0 111.0 101.0 113.0 115.0 112.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:161.00 stddev:21.22 (13.2%) stddev-sans-first:22.12 09:22:03 INFO - PROCESS | 1884 | Values: 166.0 132.0 159.0 185.0 134.0 163.0 158.0 132.0 186.0 133.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 09:22:03 INFO - PROCESS | 1884 | Values: 161.0 162.0 160.0 161.0 161.0 161.0 161.0 162.0 164.0 161.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:21.75 (29.8%) stddev-sans-first:22.33 09:22:03 INFO - PROCESS | 1884 | Values: 74.0 74.0 106.0 117.0 74.0 73.0 73.0 128.0 104.0 73.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:23.91 (25.4%) stddev-sans-first:24.73 09:22:03 INFO - PROCESS | 1884 | Values: 94.0 96.0 140.0 94.0 94.0 95.0 145.0 93.0 94.0 146.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 09:22:03 INFO - PROCESS | 1884 | Values: 119.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:22:03 INFO - PROCESS | 1884 | Values: 147.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:22:03 INFO - PROCESS | 1884 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:65.50 stddev:6.15 (9.4%) stddev-sans-first:6.48 09:22:03 INFO - PROCESS | 1884 | Values: 65.0 66.0 65.0 69.0 64.0 66.0 65.0 84.0 64.0 63.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 09:22:03 INFO - PROCESS | 1884 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.24 09:22:03 INFO - PROCESS | 1884 | Values: 83.0 84.0 84.0 83.0 85.0 83.0 84.0 85.0 87.0 85.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:143.00 stddev:10.69 (7.5%) stddev-sans-first:11.30 09:22:03 INFO - PROCESS | 1884 | Values: 141.0 148.0 147.0 145.0 137.0 135.0 138.0 136.0 171.0 138.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:2.63 (1.5%) stddev-sans-first:1.50 09:22:03 INFO - PROCESS | 1884 | Values: 178.0 172.0 170.0 171.0 173.0 172.0 168.0 172.0 171.0 170.0 09:22:03 INFO - PROCESS | 1884 | 09:22:03 INFO - PROCESS | 1884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 09:22:03 INFO - PROCESS | 1884 | Values: 72.0 73.0 73.0 73.0 73.0 73.0 72.0 71.0 73.0 73.0 09:22:03 INFO - PROCESS | 1884 | -------- Summary: end -------- 09:22:03 INFO - PROCESS | 1884 | 09:22:04 INFO - TEST-INFO | 1884: exit 0 09:22:04 INFO - TEST-OK | kraken | took 62935ms 09:22:04 INFO - SUITE-END | took 1181s 09:22:04 INFO - Completed test suite (00:19:41) 09:22:04 INFO - javascript benchmark 09:22:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.275024368299, 2678.223315238581, 2703.5809449535327, 2718.537848565744, 2726.9863650681746, 4513.932291015637, 4589.747563883985, 4670.206064968955, 4688.648351373644, 4725.220338644124, 4651.953480465194, 4660.091282199973, 4677.181493238678, 4729.12511185431, 4734.218853889112, 4226.070264541796, 4297.634701050414, 4341.305391137419, 4371.1913296040175, 4440.289553671413, 4368.716033457831, 4396.054848207635, 4411.09572537629, 4425.7565833879125, 4452.3544086107495, 4205.390218418327, 4222.451081359403, 4295.312749960022, 4307.504636966758, 4316.503602085769, 4200.558941311179, 4265.019045619525, 4269.402283680287, 4277.059047009653, 4312.956870431287, 4247.617714405718, 4284.078923031532, 4289.914201715979, 4295.935560966556, 4324.437823083011, 4422.314541246112, 4515.63874890008, 4542.136993971135, 4591.265397536378, 4616.169089563878, 4960.578350840183, 4960.90078198434, 4968.354113965162, 4984.725840078794, 4997.950020499785, 4989.775460104268, 4996.1756310208775, 4998.950010499885, 4999.0501804657, 5027.723475208862, 4489.326601009875, 4594.517575654575, 4651.093036857848, 4684.063187362541, 4695.882602934954, 4987.975060124676, 5000.599952003831, 5002.024605202024, 5004.924926126111, 5048.192289233779, 4815.662903596714, 4817.975910120427, 4819.325294458778, 4829.082474329866, 4850.878728031827, 4927.655064145547, 4943.826966056171, 4976.701397916137, 5015.272785446163, 5034.672746271481, 4957.231629097496, 4962.900741985212, 4972.477889821516, 4984.40187177541, 5031.572316353151, 4820.927686084711, 4956.207006878954, 4960.578350840146, 4969.130402179604, 5011.373578302712, 4176.331786914079, 4187.895302617398, 4256.531781504032, 4263.147370525907, 4265.274903266452, 3657.74395792292, 3688.0964163780045, 3688.280785246851, 3723.1622884851236, 3725.3480640887738, 4328.415663885398, 4348.5216626171095, 4348.67384946124, 4350.825966961349, 4389.012472193731, 4828.420589529279, 5038.395392552917, 5073.898522029539, 5102.209157580581, 5118.104331742004, 4327.82688692455, 4328.3723860040745, 4348.934765978513, 4349.630281426114, 4391.956080439155, 4366.694331396835, 4508.211063063951, 4509.594136527663, 4518.299663552155, 4544.750038747835, 4656.231721765938, 4701.717896926195, 4707.199776038014, 4745.169595320874, 4747.62019038483, 4961.531169232843, 4998.775055122601, 5001.24981252815, 5002.199648056294, 5047.318611987334, 4589.311603259538, 4704.647151463585, 4712.410948631421, 4730.077634861169, 4761.595264402565, 4894.19245824435, 4916.950830491649, 4917.680350777188, 4937.703737775745, 4967.453580106113, 4953.702777833341, 4976.576990955809, 4977.104121258063, 4983.0, 5002.0, 4711.316859055486, 4804.975975120102, 4838.346823178826, 4885.096257192431, 4888.193448081027, 4851.708897466164, 4866.95133048665, 4870.09903167915, 4897.877553061202, 4905.117078925685, 4791.520847915181, 4808.471068182567, 4812.06164797861, 4818.253170758538, 4866.586340161126, 4741.383620129361, 4790.568848803624, 4882.584980276716, 4909.140900342497, 4940.6788558743565, 4676.251799712029, 4799.9760001199775, 4830.903381932412, 4834.758262086812, 4861.951380486292], "value": 4581.409107041932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2200236665119, 597.8027251007171, 597.9491743201828, 609.591573645658, 616.1712496691949, 26480.0, 26706.465870682576, 26873.0594429195, 26889.19332420028, 33679.15802104949, 34663.82668086662, 35055.0, 35088.64911350886, 35154.64845351546, 36809.0, 7573.242675732437, 7804.960975195145, 7817.8827317590285, 7828.725994590191, 7831.334336581397, 7477.252274772506, 7641.3886889048745, 7791.532508049507, 9538.475383853885, 9736.464494452803, 9779.21766258701, 9950.701478955643, 9957.352772069793, 9963.402195868235, 9974.0, 9702.320837541374, 9819.116279534805, 9842.4586647734, 9847.261455390875, 9851.162651174658, 9639.277054220962, 9751.317407781458, 9754.609815607368, 9762.219022478255, 9767.365121267096, 29934.401311973637, 38188.04529886747, 38436.23127537434, 38714.03214919649, 38749.61250387488, 2263.779061228159, 2366.562185995579, 2490.8256422050463, 2581.328854497844, 3030.7878448508613, 22466.502925377863, 28629.427411451863, 28680.569791453145, 28938.71061289402, 29361.853190734124, 3472.2187507810795, 3486.4421692529327, 3520.2959408118477, 3597.478365636994, 3605.549306336708, 196747.0, 198319.0, 199022.0, 200058.0, 200454.0, 53228.0, 53948.73025634847, 53974.46025539773, 53998.19002714963, 54083.45916540784, 56197.0, 60165.38180800108, 60267.39732602706, 60461.39538604645, 60568.0, 14610.342534585969, 14770.704585908437, 14783.334749936279, 14793.334299956528, 14795.334209960578, 10193.592256309812, 11715.88284117165, 11924.582639607746, 11949.522019119138, 11950.521979120911, 18558.907205463885, 18896.90551547261, 19066.90466547686, 19185.136668849937, 19240.0, 6930.792076237721, 7045.330693584101, 7179.676914538858, 7234.782956511313, 7285.963570182221, 891.9910800891907, 960.1358777100666, 962.5476026267643, 991.6083147156833, 993.7962717642865, 24862.0, 26658.0, 26728.198154055408, 27575.255178474865, 28138.577921330787, 999.415342024909, 1001.6627801884566, 1052.9832031230621, 1069.027185261424, 1074.5003573338436, 14235.288235588387, 14730.189839558927, 14736.115833050051, 14793.334299956528, 15154.242287885561, 339078.0, 344363.0, 344789.0, 344922.0, 347268.0, 47382.0, 48895.26657100146, 49009.26486102711, 49010.0, 49032.264516032286, 1068.8877667844765, 1171.6367925942814, 1238.5107882386587, 1279.302779984929, 1330.9201447913156, 25447.36381590475, 27457.862710687117, 27570.10513896012, 27804.443911122067, 28044.29889252785, 38786.4182037264, 39244.80377598094, 39293.803530982164, 39304.0, 39343.0, 184170.0, 185192.0, 185760.0, 185888.0, 186198.0, 32248.516272255467, 32305.35389292248, 38781.41827872641, 41198.1760364785, 41837.58162418459, 35336.293274134885, 42725.57274427216, 43824.12351753011, 44393.778031109636, 44572.77713611411, 32381.83809081034, 33931.3213735719, 34579.65420345764, 34877.47683784796, 35145.47281790724, 33566.0, 34309.142271443416, 34405.0, 34497.482537761454, 34652.0, 34116.658833412344, 34597.30805383928, 34639.88533662383, 34830.12924676802, 34934.47598285977, 30060.69939300579, 30212.84893575606, 30696.232594185323, 30997.0, 31032.53451198189, 23426.64860027067, 23826.761732383147, 24025.16665418293, 24414.26757197287, 24448.755512444648], "value": 17299.93535830463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.47011952191224, 386.6249737754378, 388.2603640065676, 399.1697269679068, 400.5433805461772, 13592.592222233325, 14150.858491415083, 15516.612084697888, 17555.2100155493, 18068.09659517024, 16082.115483648395, 16193.190340482988, 16856.831431685678, 17508.82491175088, 17559.0, 4566.817327306904, 5156.845294641157, 5313.574914006889, 5340.25236466895, 5353.892922141555, 3739.289534988357, 5276.525112739852, 5749.885002299951, 6057.091436284549, 6062.757489700407, 6015.608985415934, 6023.216981792383, 6034.487068599175, 6048.939510604903, 6054.243219597551, 5966.045432730764, 6057.030875059969, 6057.606255593372, 6060.848478788022, 6065.818025459222, 5171.870703232449, 5187.221916712523, 5370.060239458118, 5370.409254981949, 5462.6995515246645, 11648.825267620992, 12330.260184388966, 20481.5903681927, 20645.793542064537, 20660.276890308767, 1907.4754442528276, 1933.01416277698, 1978.4361456984834, 2182.1380554680973, 2204.393791707277, 8789.165029322205, 9129.680461183892, 9294.024127466586, 9440.197583205436, 9720.659776907845, 1616.5554472520034, 1663.717168081429, 1705.914704264782, 1767.2312544043255, 1776.6180271241744, 68320.31679683189, 70759.64620176918, 71795.28204717938, 74013.0, 76195.38046195336, 10235.948820255851, 10250.231232657581, 10331.48342582868, 10377.377357358582, 10479.84280235797, 14397.208153551655, 14551.563453096423, 14556.854431455762, 14579.92710036443, 14609.488667896572, 7343.742968996059, 7561.3194812467145, 7633.923660763321, 7718.652660630285, 7736.0, 6813.625250611165, 6977.406920411822, 6993.405560527311, 7057.435405167575, 7256.0567126273245, 4403.867883963422, 4450.532694067141, 4497.257952437811, 4559.635229181657, 4561.931571026437, 1746.1182103038138, 1782.295993082725, 1799.73004049391, 1815.2285278756476, 1838.1268897273687, 775.7323723315448, 890.1143362354369, 905.3029167540957, 921.9078092190728, 967.6322997260996, 15713.21433928299, 15868.365265389486, 16662.250198741087, 16841.894763154607, 17072.0, 843.1610547505271, 874.8643960186181, 888.1562515610196, 922.4327038871046, 938.5588773276686, 8999.865002024975, 9197.81604367909, 9220.0, 9235.307351948632, 9378.577963991636, 398458.0, 398914.0, 402994.0, 406919.0, 415868.0, 78103.0, 82812.0, 84596.0, 85411.5729421349, 85667.57166214254, 961.1541843177959, 983.2379905573094, 985.2364417576435, 993.9503024848873, 1011.9898801012043, 14444.277786110863, 14491.637709057359, 14510.201938893462, 15683.529494115195, 15700.214989250264, 31726.365472689955, 32232.83883580567, 33839.0, 33845.83077084599, 33930.66069339275, 48702.75648621734, 50493.49506504888, 51666.0, 51692.48307516877, 52226.73886630694, 7527.8118047049265, 7631.771046868603, 7676.117246516722, 7723.1118421380015, 7733.613319333898, 8181.509109453452, 11038.779224415628, 11397.715057123638, 11639.59261425846, 11663.416829158678, 9649.951750241204, 10391.403917516507, 10431.478426078818, 10487.0, 10535.15718742514, 9821.214302855897, 9952.353097048668, 10102.242331824995, 10141.239407044648, 10184.898151018395, 9733.318667693193, 10175.135113515435, 10304.381737095799, 10331.690049298533, 10395.740106497398, 7397.889031664422, 7433.665485053294, 7447.925520744723, 7544.698212071456, 7547.886781698388, 8860.158284962918, 9929.255305851946, 9939.055789699967, 10002.099811017044, 10056.29605927578], "value": 8238.273004886678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.0166971432004, 1298.6233992142277, 1380.0339762166484, 1392.3734319556202, 1636.6808472347898, 6733.898991515125, 7556.055493063367, 7754.37964962803, 7758.456908016441, 7760.883586746203, 7484.288992545713, 7646.96176519118, 7665.1951545087795, 7666.769996900102, 7667.501612395205, 1910.4173227165709, 1973.2205778717398, 2175.932863779408, 2211.568744094898, 2246.7079279693617, 2225.6550234713645, 2241.4508445430893, 2244.16965722682, 2253.4479052632046, 2256.0, 2160.049578185601, 2167.4147980045377, 2195.1877805212016, 2197.549502352022, 2197.8351623628214, 1880.7178923161566, 2092.8953552322323, 2126.617208902397, 2160.481484443738, 2161.146347192866, 2166.2959538150008, 2170.4899348653053, 2180.803727664502, 2193.429708275844, 2197.9560408791895, 7731.188225236382, 7769.339606133485, 7815.335696465807, 7817.0, 7839.568823714693, 4443.800028998703, 4625.236835922069, 4631.374764406795, 4637.536246375369, 4653.0693861227555, 3008.473517134493, 3048.908532743999, 3080.3993221321853, 3091.0, 3141.921451963696, 1020.8009438159562, 1030.2118879057527, 1047.3454091193005, 1703.429351167348, 1724.4912750738438, 10228.38629682214, 10236.0, 10268.0, 10375.896241037568, 10379.0, 3911.8435262589746, 3998.3202855514633, 4057.208844275338, 4136.627703506699, 4138.544760076389, 8120.390970677223, 8182.631781569725, 8184.2224988625985, 8194.590270486451, 8195.549244791593, 4475.239209334421, 4484.0, 4492.146492166478, 4501.954980450154, 4504.369388285642, 3770.830312635938, 4150.750954942653, 4203.894902627459, 4219.725717828393, 4224.5003023926065, 3447.844846981842, 3463.6363181866045, 3570.91072723184, 3591.676749092594, 3603.4774957631, 1068.4390694885246, 1100.818364969771, 1103.668899330214, 1114.3091283404342, 1122.6070875193616, 794.7417089445837, 893.660409044559, 915.9878334440348, 922.6078916460477, 937.6765016069445, 5378.865528361744, 5511.311086114236, 5572.108462646038, 5627.662340259598, 5666.03677374839, 414.50673698298925, 419.27256210474803, 426.9135051294463, 432.08613781851784, 433.3348310343607, 3810.3522401191863, 3846.7307288489537, 3867.16855875988, 3931.8820435386983, 4047.8583249586122, 9429.198518126037, 9632.95183524092, 9644.517774111408, 9771.9022809771, 9776.266779991529, 9499.90500095004, 9720.07659272382, 9759.219262458986, 9762.951185244028, 9768.90231097694, 6807.353301436356, 6839.931600684128, 7005.1944026436595, 7014.298570142945, 7024.473164512682, 5482.39693633708, 5588.38527761954, 5611.130274807411, 5647.435256474319, 5743.971280143573, 8841.204291613785, 8926.152015558511, 8982.685606003759, 9030.096990300917, 9094.226990705863, 8928.955355223183, 8983.685571004984, 9059.728208153765, 9205.723828285161, 9211.723648290563, 6193.38066193377, 6504.934950650433, 6770.322967703387, 6789.93210067893, 6894.207166175954, 7360.374368178551, 7380.741674041383, 7444.702211911463, 7453.515521491086, 7456.701731930662, 6520.18497687789, 6549.541532092899, 6581.835454113685, 6603.042558828847, 6825.180978282638, 6692.765753198614, 6702.597844129368, 6746.392824645805, 6787.626680532618, 6831.658417079226, 6424.710888010144, 6449.96775016122, 6511.2512061113575, 6515.54391192612, 6518.0, 4819.397575303087, 4824.758762061953, 4915.582175515121, 4921.483244259444, 4957.851264462072, 4671.883202919954, 4694.7887345068875, 4707.788149533348, 4832.34763306949, 4841.080194762983], "value": 4092.371503521669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4084654189427, 320.2458210913299, 320.74340527577937, 321.2899492122409, 327.2326394604651, 5040.269160971657, 5108.616853735971, 5119.564836988856, 5129.589632829374, 5146.279520867072, 5055.494450554943, 5057.696538207711, 5081.16160833463, 5085.135526960416, 5095.363079615048, 3783.6405541473514, 3834.6357096075826, 3951.723379363446, 3994.7802870842092, 4038.232735780207, 3964.5837187095226, 3991.560928297885, 4002.919941601166, 4027.879163625081, 4030.7380020298588, 3739.775613463201, 3975.5030621172355, 3988.621080997315, 3992.3412636914873, 3994.4407782910416, 3874.4769456123486, 3981.960180398217, 3993.1614360983936, 4005.299072662287, 4022.2357752027315, 3518.876839310612, 3547.7871327720163, 3556.8577256909693, 3557.7509574329806, 3572.374834403969, 4822.0, 4858.149823780825, 4860.756962151913, 4880.902381952376, 4882.194437917739, 4359.629431498326, 4583.014651849869, 4600.102979918917, 4604.263317869125, 4608.884777880547, 5271.789128434858, 5282.339707536558, 5288.788448462057, 5296.470352964711, 5327.946720532823, 3893.1824316893485, 3893.552241492208, 3894.123822140024, 3900.9219815603815, 3904.4533765272886, 5468.179773034037, 5523.972380138114, 5553.222548843165, 5584.246126772915, 5584.329880414376, 3973.7218394712095, 3992.6606238470054, 3994.800259986989, 3996.1208534122447, 4008.158286759755, 4058.2492238935893, 4062.979685101556, 4063.6139566741113, 4064.1058967027207, 4072.735272207297, 4411.338299255138, 4573.794179261941, 4574.879154607076, 4585.679002469862, 4587.9541204588195, 5325.254464374991, 5325.4940780625775, 5331.306930099062, 5337.466253374631, 5339.0, 1374.8900087992936, 1402.7965944937928, 1407.4370251899322, 1413.0814970269203, 1417.362187015847, 903.4850135422746, 955.9330846840794, 979.1872745621259, 996.3673067602125, 1005.5977608956476, 4703.976480117578, 4708.929366059512, 4722.504137065559, 4729.456112547101, 4733.644976626698, 5469.781208751685, 5469.945300547023, 5475.233467314579, 5485.643433176911, 5486.451354864482, 4569.405977223007, 4646.395968524071, 4662.246891252575, 4713.67004309695, 4843.854684359404, 2951.6900725423952, 2965.4365670522534, 2976.300569366197, 2987.9691506430245, 2988.5666578346454, 5241.580673546107, 5244.9737751310995, 5251.396089449686, 5258.868528286824, 5260.421353651095, 5484.506394424521, 5670.0, 5679.683440585102, 5682.857928551819, 5708.686022268732, 5210.322658054429, 5229.843104706865, 5230.137027390438, 5232.215167724872, 5233.895322093536, 5436.53789427903, 5549.38956714753, 5563.193336966198, 5575.386707462257, 5578.888422231452, 5433.5924805640525, 5453.972730136324, 5458.399576046552, 5466.91799622998, 5477.890442191214, 5209.869753256199, 5214.947850521598, 5247.7113758743635, 5251.606129540223, 5253.185756207794, 3769.981150094232, 3852.9229415410973, 3880.844766209433, 3884.6503814656817, 3889.669378102893, 5512.310961129859, 5523.420040895809, 5533.146395957399, 5539.972300138474, 5545.306836645419, 5330.173823057432, 5346.572274217975, 5351.892962140813, 5366.517013468807, 5367.6779393234965, 5131.230315452712, 5320.477594045031, 5321.627486075938, 5335.519803217729, 5360.43715409892, 5069.5944324454695, 5275.287836142072, 5293.417724050274, 5295.126304159925, 5317.468253174651, 5223.921641175461, 5309.309789727466, 5323.0684630190335, 5325.174597937326, 5334.11987022137, 5271.393789714232, 5286.735663216747, 5291.100512912737, 5297.788088476418, 5319.41486436484], "value": 4055.539154892149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.937406259374, 683.1699485125572, 707.003125592914, 719.74089327842, 761.5392687424112, 11181.105511559075, 11234.887651123476, 11292.548298068068, 11860.466279017453, 12605.180663256904, 12612.180208286454, 12750.553730619431, 12790.744185116291, 12796.360181990909, 12797.936010319936, 640.5292110298926, 802.1377019703828, 811.7077851973285, 817.3297895725508, 818.30444122496, 782.86299897518, 807.096052421289, 811.8701007838747, 812.0620683111016, 812.3704129299781, 838.9454685445457, 842.3177226446597, 843.5782108945527, 843.633019636457, 843.6583183810567, 651.8240075179723, 831.5135645647304, 839.4543546694637, 839.5676226743202, 841.8021764885247, 610.697704636208, 614.6373639552685, 617.9412955769195, 618.0173524096708, 618.9319174890759, 12192.329421881794, 12242.204256723284, 12245.448954796966, 12252.877471225263, 12258.1419300649, 11970.281783092954, 12516.81224781629, 13105.14816536922, 13105.868941310655, 13390.0, 9708.805823883553, 9749.951250243774, 9826.557804898797, 10213.2850700451, 10231.23265755064, 4203.159368126387, 4207.789610519461, 4254.872353829359, 4328.805203765838, 4436.866893993185, 40509.59490405088, 40620.59379406198, 41411.7929410351, 41565.1686966262, 41928.58071419277, 9639.325247232766, 9820.754481138028, 9868.161206297402, 9891.60433582663, 10056.597736090474, 17344.13279336028, 18538.814611853708, 18557.44327670172, 18573.628527429646, 18588.907055464635, 6656.900146497709, 6751.932480675228, 6848.863022739517, 6894.379505844498, 6976.825579360557, 3732.9066773330883, 3776.188119554309, 3839.673627741673, 3856.82644281008, 3926.155876486569, 2973.4796410628055, 3077.646070701853, 3081.644076606286, 3088.6139232595924, 3096.829674367886, 514.3673281863329, 518.8234073356695, 528.20241435432, 529.3436139187456, 543.4701166362764, 455.71973236459337, 542.8100164942239, 609.8810731907324, 624.0825985800956, 635.3582881289931, 7113.679884405215, 7300.306470885257, 7440.181580026193, 7559.811004724816, 7878.369730421553, 617.7312868901952, 628.1959092361693, 635.732992143301, 644.3427703742157, 652.9444997175293, 3470.5661792275964, 3486.738494612914, 3505.596856361551, 3555.5911070227253, 3634.454831775202, 50275.24587131196, 51027.23459148116, 51343.7432812841, 51433.48566514362, 51622.74188629033, 45204.321935171, 45768.54231457709, 46127.0, 46273.76863115663, 46319.76840115778, 40821.591784082375, 41082.0, 41425.0, 41606.375904361455, 41751.1649767003, 6886.242463501042, 6948.409385202314, 7031.859362812817, 7070.964645176741, 7187.281271872771, 26664.20007399781, 27263.182104536896, 27357.179284621492, 27575.0, 27991.860040699667, 34932.301353973286, 36566.63433365632, 37811.81094094512, 37907.81046094752, 38043.80978095092, 9580.18568421692, 9679.467629280458, 9888.703338899844, 9906.405615663083, 10174.084332409822, 10635.840462392916, 10659.467026648792, 10805.298675331167, 10864.891351086388, 10873.673789786319, 9869.25980551476, 10070.546825392728, 10317.27779055459, 10406.843897341394, 10541.947290263499, 8770.780730481789, 8867.866981995405, 9122.680706175252, 9127.543622818965, 9323.627054917728, 9635.710928672152, 9785.266105042008, 9863.605455781688, 9919.851202231828, 10268.691939241835, 7904.328132108835, 8030.799230019296, 8159.428839981382, 8182.713605023796, 8390.412671112963, 7884.741583311863, 8201.95899020501, 8301.626426810928, 8337.874931876147, 8405.53769542681], "value": 5766.550654683282, "unit": "score"}], "name": "dromaeo_css", "value": 6299.573728046318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 107.0, 111.0, 113.0, 111.0, 101.0, 113.0, 115.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 132.0, 159.0, 185.0, 134.0, 163.0, 158.0, 132.0, 186.0, 133.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 164.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 106.0, 117.0, 74.0, 73.0, 73.0, 128.0, 104.0, 73.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 140.0, 94.0, 94.0, 95.0, 145.0, 93.0, 94.0, 146.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 69.0, 64.0, 66.0, 65.0, 84.0, 64.0, 63.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 85.0, 83.0, 84.0, 85.0, 87.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 148.0, 147.0, 145.0, 137.0, 135.0, 138.0, 136.0, 171.0, 138.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 172.0, 170.0, 171.0, 173.0, 172.0, 168.0, 172.0, 171.0, 170.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0, 71.0, 73.0, 73.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1588.6, "alertThreshold": 2.0}]} 09:22:04 INFO - Return code: 0 09:22:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:22:04 ERROR - # TBPL SUCCESS # 09:22:04 INFO - Running post-action listener: _resource_record_post_action 09:22:04 INFO - Running post-run listener: _resource_record_post_run 09:22:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517136384; Read time: 8; Write time: 339388 09:22:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 158109696; Read time: 0; Write time: 128824 09:22:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283152384; Read time: 8; Write time: 176452 09:22:06 INFO - Running post-run listener: _upload_blobber_files 09:22:06 INFO - Blob upload gear active. 09:22:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:22:06 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 09:22:06 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:22:06 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:22:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:07 INFO - (blobuploader) - INFO - Done attempting. 09:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:08 INFO - (blobuploader) - INFO - Done attempting. 09:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:22:08 INFO - Return code: 0 09:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32127a4f6f3541d380a02cc223889352383fc1f0cbcb5cd9af2723e5f676cef01de0b54e4d35ccb1c26959a2261abff1cf27c3db6d659eb34202c767b4c802a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d9a5df387b89d096a85afbad5e49e1ad762eda2b988014628241f8214df1fe35b6a3b5f4234329b201aa810e8ed1397456fa48c78c2bf70eed15b2731612856"} 09:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:22:08 INFO - Contents: 09:22:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32127a4f6f3541d380a02cc223889352383fc1f0cbcb5cd9af2723e5f676cef01de0b54e4d35ccb1c26959a2261abff1cf27c3db6d659eb34202c767b4c802a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d9a5df387b89d096a85afbad5e49e1ad762eda2b988014628241f8214df1fe35b6a3b5f4234329b201aa810e8ed1397456fa48c78c2bf70eed15b2731612856"} 09:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:22:08 INFO - Copying logs to upload dir... 09:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.375573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-14 09:22:08.196220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:08.199950) ========= 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-1460646420.773127-1544315099 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-Non-PGO/sha512/32127a4f6f3541d380a02cc223889352383fc1f0cbcb5cd9af2723e5f676cef01de0b54e4d35ccb1c26959a2261abff1cf27c3db6d659eb34202c767b4c802a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d9a5df387b89d096a85afbad5e49e1ad762eda2b988014628241f8214df1fe35b6a3b5f4234329b201aa810e8ed1397456fa48c78c2bf70eed15b2731612856"} build_url:https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/32127a4f6f3541d380a02cc223889352383fc1f0cbcb5cd9af2723e5f676cef01de0b54e4d35ccb1c26959a2261abff1cf27c3db6d659eb34202c767b4c802a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d9a5df387b89d096a85afbad5e49e1ad762eda2b988014628241f8214df1fe35b6a3b5f4234329b201aa810e8ed1397456fa48c78c2bf70eed15b2731612856"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:08.225743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:08.226119) ========= 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-1460646420.773127-1544315099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:08.310796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:22:08.311151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:22:08.311504) ========= ========= Total master_lag: 0.19 =========