builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1466521647.21 results: success (0) buildid: 20160621053017 builduid: 075dc87d889e47ae8458fcd6531781d7 revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.212155) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.212604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.212886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.278610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.278966) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:07:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-06-21 08:07:27 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.257412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.561694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.562024) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.153919 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.728828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:27.729244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb945fc547afc9a4254ef339335fe831c0f68db2 --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 eb945fc547afc9a4254ef339335fe831c0f68db2 --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=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:07:27,759 truncating revision to first 12 chars 2016-06-21 08:07:27,759 Setting DEBUG logging. 2016-06-21 08:07:27,759 attempt 1/10 2016-06-21 08:07:27,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb945fc547af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:07:28,065 unpacking tar archive at: fx-team-eb945fc547af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:28.396546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:28.396901) ========= script_repo_revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:28.397350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:28.397662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:07:28.408355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-21 08:07:28.408816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:28 INFO - MultiFileLogger online at 20160621 08:07:28 in /builds/slave/test 08:07:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:07:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:28 INFO - {'append_to_log': False, 08:07:28 INFO - 'base_work_dir': '/builds/slave/test', 08:07:28 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:28 INFO - 'branch': 'Fx-Team', 08:07:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:28 INFO - 'config_files': ('talos/linux_config.py',), 08:07:28 INFO - 'default_actions': ('clobber', 08:07:28 INFO - 'read-buildbot-config', 08:07:28 INFO - 'download-and-extract', 08:07:28 INFO - 'populate-webroot', 08:07:28 INFO - 'create-virtualenv', 08:07:28 INFO - 'install', 08:07:28 INFO - 'run-tests'), 08:07:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:28 INFO - 'download_minidump_stackwalk': True, 08:07:28 INFO - 'download_symbols': 'ondemand', 08:07:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:28 INFO - 'installer_path': 'installer.exe', 08:07:28 INFO - 'log_level': 'info', 08:07:28 INFO - 'log_name': 'talos', 08:07:28 INFO - 'log_to_console': True, 08:07:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:28 INFO - 'opt_config_files': (), 08:07:28 INFO - 'pip_index': False, 08:07:28 INFO - 'sps_profile': False, 08:07:28 INFO - 'sps_profile_interval': 0, 08:07:28 INFO - 'suite': 'dromaeojs', 08:07:28 INFO - 'system_bits': '32', 08:07:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:28 INFO - 'title': 'talos-linux64-ix-064', 08:07:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:28 INFO - 'use_talos_json': True, 08:07:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:28 INFO - 'work_dir': 'build'} 08:07:28 INFO - ##### 08:07:28 INFO - ##### Running clobber step. 08:07:28 INFO - ##### 08:07:28 INFO - Running pre-action listener: _resource_record_pre_action 08:07:28 INFO - Running main action method: clobber 08:07:28 INFO - rmtree: /builds/slave/test/build 08:07:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Finished clobber step (success) 08:07:30 INFO - ##### 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running read-buildbot-config step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: read_buildbot_config 08:07:30 INFO - Using buildbot properties: 08:07:30 INFO - { 08:07:30 INFO - "project": "", 08:07:30 INFO - "product": "firefox", 08:07:30 INFO - "script_repo_revision": "production", 08:07:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:07:30 INFO - "repository": "", 08:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:07:30 INFO - "buildid": "20160621053017", 08:07:30 INFO - "pgo_build": "True", 08:07:30 INFO - "basedir": "/builds/slave/test", 08:07:30 INFO - "buildnumber": 202, 08:07:30 INFO - "slavename": "talos-linux64-ix-064", 08:07:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:07:30 INFO - "platform": "ubuntu64_hw", 08:07:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:30 INFO - "branch": "fx-team", 08:07:30 INFO - "repo_path": "integration/fx-team", 08:07:30 INFO - "revision": "eb945fc547afc9a4254ef339335fe831c0f68db2", 08:07:30 INFO - "stage_platform": "linux64-pgo", 08:07:30 INFO - "builduid": "075dc87d889e47ae8458fcd6531781d7", 08:07:30 INFO - "slavebuilddir": "test" 08:07:30 INFO - } 08:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - ##### 08:07:30 INFO - ##### Finished read-buildbot-config step (success) 08:07:30 INFO - ##### 08:07:30 INFO - ##### 08:07:30 INFO - ##### Running download-and-extract step. 08:07:30 INFO - ##### 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: download_and_extract 08:07:30 INFO - mkdir: /builds/slave/test/build/tests 08:07: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')]} 08:07:30 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:07:41 INFO - Downloaded 1361 bytes. 08:07:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:07:41 INFO - Using the following test package requirements: 08:07:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'jsshell-linux-x86_64.zip'], 08:07:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:41 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')]} 08:07:41 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:46 INFO - Downloaded 24225158 bytes. 08:07:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:48 INFO - Return code: 0 08:07:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07:48 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')]} 08:07:48 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:49 INFO - Downloaded 24225158 bytes. 08:07:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:51 INFO - Return code: 0 08:07:51 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')]} 08:07:51 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:52 INFO - Downloaded 14405384 bytes. 08:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:07:52 INFO - Return code: 0 08:07: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')]} 08:07:52 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:53 INFO - Downloaded 60119633 bytes. 08:07:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:07:53 INFO - mkdir: /builds/slave/test/properties 08:07:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:53 INFO - Contents: 08:07:53 INFO - build_url:https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:07:56 INFO - Running post-action listener: _resource_record_post_action 08:07:56 INFO - Running post-action listener: set_extra_try_arguments 08:07:56 INFO - ##### 08:07:56 INFO - ##### Finished download-and-extract step (success) 08:07:56 INFO - ##### 08:07:56 INFO - ##### 08:07:56 INFO - ##### Running populate-webroot step. 08:07:56 INFO - ##### 08:07:56 INFO - Running pre-action listener: _resource_record_pre_action 08:07:56 INFO - Running main action method: populate_webroot 08:07:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:56 INFO - '--tppagecycles', 08:07:56 INFO - '7'], 08:07:56 INFO - 'tests': ['tsvgm']}}, 08:07:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['damp', 'tps']}, 08:07:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['damp', 'tps']}, 08:07:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['dromaeo_dom']}, 08:07:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['basic_compositor_video']}, 08:07:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:07:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['a11yr', 08:07:56 INFO - 'ts_paint', 08:07:56 INFO - 'tpaint', 08:07:56 INFO - 'sessionrestore', 08:07:56 INFO - 'sessionrestore_no_auto_restore', 08:07:56 INFO - 'tabpaint']}, 08:07:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tsvgx', 08:07:56 INFO - 'tsvgr_opacity', 08:07:56 INFO - 'tart', 08:07:56 INFO - 'tscrollx', 08:07:56 INFO - 'cart']}, 08:07:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:56 INFO - 'tsvgr_opacity', 08:07:56 INFO - 'tart', 08:07:56 INFO - 'tscrollx', 08:07:56 INFO - 'cart']}, 08:07:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s'], 08:07:56 INFO - 'tests': ['tp5o']}, 08:07:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'tests': ['tp5o']}, 08:07:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--disable-e10s', 08:07:56 INFO - '--xperf_path', 08:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:56 INFO - 'tests': ['tp5n']}, 08:07:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:56 INFO - 'talos_options': ['--xperf_path', 08:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:56 INFO - 'tests': ['tp5n']}}, 08:07:56 INFO - 'talos.zip': {'path': '', 08:07:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:56 INFO - Running post-action listener: _resource_record_post_action 08:07:56 INFO - ##### 08:07:56 INFO - ##### Finished populate-webroot step (success) 08:07:56 INFO - ##### 08:07:56 INFO - ##### 08:07:56 INFO - ##### Running create-virtualenv step. 08:07:56 INFO - ##### 08:07:56 INFO - Running pre-action listener: _resource_record_pre_action 08:07:56 INFO - Running main action method: create_virtualenv 08:07:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:56 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 08:07:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:56 INFO - Using real prefix '/usr' 08:07:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:59 INFO - Installing pip.................done. 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 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 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:07:59 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 08:07:59 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 08:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 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 08:07:59 INFO - Cleaning up... 08:07:59 INFO - Return code: 0 08:07:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:07:59 INFO - Using env: {'DISPLAY': ':0', 08:07:59 INFO - 'HOME': '/home/cltbld', 08:07:59 INFO - 'LANG': 'en_US.UTF-8', 08:07:59 INFO - 'LANGUAGE': 'en_US:en', 08:07:59 INFO - 'LOGNAME': 'cltbld', 08:07:59 INFO - 'MAIL': '/var/mail/cltbld', 08:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:59 INFO - 'MOZ_NO_REMOTE': '1', 08:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:59 INFO - 'NO_EM_RESTART': '1', 08:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:59 INFO - 'PWD': '/builds/slave/test', 08:07:59 INFO - 'SHELL': '/bin/bash', 08:07:59 INFO - 'SHLVL': '1', 08:07:59 INFO - 'TERM': 'linux', 08:07:59 INFO - 'TMOUT': '86400', 08:07:59 INFO - 'USER': 'cltbld', 08:07:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:59 INFO - '_': '/tools/buildbot/bin/python'} 08:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:59 INFO - Downloading/unpacking psutil>=3.1.1 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:02 INFO - Installing collected packages: psutil 08:08:02 INFO - Running setup.py install for psutil 08:08:02 INFO - building 'psutil._psutil_linux' extension 08:08:02 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 08:08:03 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 08:08:03 INFO - building 'psutil._psutil_posix' extension 08:08:03 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 08:08:03 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 08:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:03 INFO - Successfully installed psutil 08:08:03 INFO - Cleaning up... 08:08:03 INFO - Return code: 0 08:08:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:08:03 INFO - Using env: {'DISPLAY': ':0', 08:08:03 INFO - 'HOME': '/home/cltbld', 08:08:03 INFO - 'LANG': 'en_US.UTF-8', 08:08:03 INFO - 'LANGUAGE': 'en_US:en', 08:08:03 INFO - 'LOGNAME': 'cltbld', 08:08:03 INFO - 'MAIL': '/var/mail/cltbld', 08:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:03 INFO - 'MOZ_NO_REMOTE': '1', 08:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:03 INFO - 'NO_EM_RESTART': '1', 08:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:03 INFO - 'PWD': '/builds/slave/test', 08:08:03 INFO - 'SHELL': '/bin/bash', 08:08:03 INFO - 'SHLVL': '1', 08:08:03 INFO - 'TERM': 'linux', 08:08:03 INFO - 'TMOUT': '86400', 08:08:03 INFO - 'USER': 'cltbld', 08:08:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:03 INFO - '_': '/tools/buildbot/bin/python'} 08:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:03 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 08:08:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:05 INFO - Installing collected packages: mozsystemmonitor 08:08:05 INFO - Running setup.py install for mozsystemmonitor 08:08:05 INFO - Successfully installed mozsystemmonitor 08:08:05 INFO - Cleaning up... 08:08:05 INFO - Return code: 0 08:08:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08:05 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')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 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')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:05 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==2.5.1'] in /builds/slave/test/build 08:08:05 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==2.5.1 08:08:05 INFO - Using env: {'DISPLAY': ':0', 08:08:05 INFO - 'HOME': '/home/cltbld', 08:08:05 INFO - 'LANG': 'en_US.UTF-8', 08:08:05 INFO - 'LANGUAGE': 'en_US:en', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MAIL': '/var/mail/cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SHLVL': '1', 08:08:05 INFO - 'TERM': 'linux', 08:08:05 INFO - 'TMOUT': '86400', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - '_': '/tools/buildbot/bin/python'} 08:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:08 INFO - warning: no files found matching '*.txt' 08:08:08 INFO - no previously-included directories found matching 'build' 08:08:08 INFO - no previously-included directories found matching 'dist' 08:08:08 INFO - no previously-included directories found matching '.git*' 08:08:08 INFO - Installing collected packages: jsonschema, functools32 08:08:08 INFO - Running setup.py install for functools32 08:08:08 INFO - warning: no files found matching '*.txt' 08:08:08 INFO - no previously-included directories found matching 'build' 08:08:08 INFO - no previously-included directories found matching 'dist' 08:08:08 INFO - no previously-included directories found matching '.git*' 08:08:08 INFO - Successfully installed jsonschema functools32 08:08:08 INFO - Cleaning up... 08:08:08 INFO - Return code: 0 08:08:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:08 INFO - Using env: {'DISPLAY': ':0', 08:08:08 INFO - 'HOME': '/home/cltbld', 08:08:08 INFO - 'LANG': 'en_US.UTF-8', 08:08:08 INFO - 'LANGUAGE': 'en_US:en', 08:08:08 INFO - 'LOGNAME': 'cltbld', 08:08:08 INFO - 'MAIL': '/var/mail/cltbld', 08:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:08 INFO - 'MOZ_NO_REMOTE': '1', 08:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:08 INFO - 'NO_EM_RESTART': '1', 08:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:08 INFO - 'PWD': '/builds/slave/test', 08:08:08 INFO - 'SHELL': '/bin/bash', 08:08:08 INFO - 'SHLVL': '1', 08:08:08 INFO - 'TERM': 'linux', 08:08:08 INFO - 'TMOUT': '86400', 08:08:08 INFO - 'USER': 'cltbld', 08:08:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:08 INFO - '_': '/tools/buildbot/bin/python'} 08:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:11 INFO - Downloading docopt-0.6.1.tar.gz 08:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:11 INFO - Running setup.py install for blobuploader 08:08:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:11 INFO - Running setup.py install for requests 08:08:11 INFO - Running setup.py install for docopt 08:08:11 INFO - Successfully installed blobuploader requests docopt 08:08:11 INFO - Cleaning up... 08:08:12 INFO - Return code: 0 08:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:12 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')]} 08:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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')]} 08:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:12 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 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:12 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 08:08:12 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 08:08:12 INFO - Using env: {'DISPLAY': ':0', 08:08:12 INFO - 'HOME': '/home/cltbld', 08:08:12 INFO - 'LANG': 'en_US.UTF-8', 08:08:12 INFO - 'LANGUAGE': 'en_US:en', 08:08:12 INFO - 'LOGNAME': 'cltbld', 08:08:12 INFO - 'MAIL': '/var/mail/cltbld', 08:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:12 INFO - 'MOZ_NO_REMOTE': '1', 08:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:12 INFO - 'NO_EM_RESTART': '1', 08:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:12 INFO - 'PWD': '/builds/slave/test', 08:08:12 INFO - 'SHELL': '/bin/bash', 08:08:12 INFO - 'SHLVL': '1', 08:08:12 INFO - 'TERM': 'linux', 08:08:12 INFO - 'TMOUT': '86400', 08:08:12 INFO - 'USER': 'cltbld', 08:08:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:12 INFO - '_': '/tools/buildbot/bin/python'} 08:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:12 INFO - Running setup.py (path:/tmp/pip-7cTcXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:12 INFO - Running setup.py (path:/tmp/pip-EuCORC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:12 INFO - Running setup.py (path:/tmp/pip-CHj0iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:12 INFO - Running setup.py (path:/tmp/pip-EglUqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:12 INFO - Running setup.py (path:/tmp/pip-OiG_u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:12 INFO - Running setup.py (path:/tmp/pip-hxyWf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:12 INFO - Running setup.py (path:/tmp/pip-PFRj8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:12 INFO - Running setup.py (path:/tmp/pip-kzf1aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:12 INFO - Running setup.py (path:/tmp/pip-j0A8jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:12 INFO - Running setup.py (path:/tmp/pip-h8paFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:12 INFO - Running setup.py (path:/tmp/pip-smC62p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:13 INFO - Running setup.py (path:/tmp/pip-hZzHqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:13 INFO - Running setup.py (path:/tmp/pip-ZdUlx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:13 INFO - Running setup.py (path:/tmp/pip-UFE1bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:13 INFO - Running setup.py (path:/tmp/pip-MHsUsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:13 INFO - Running setup.py (path:/tmp/pip-ua81Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:13 INFO - Running setup.py (path:/tmp/pip-1vbnK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:13 INFO - Running setup.py install for manifestparser 08:08:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:13 INFO - Running setup.py install for mozcrash 08:08:13 INFO - Running setup.py install for mozdebug 08:08:13 INFO - Running setup.py install for mozdevice 08:08:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:13 INFO - Running setup.py install for mozfile 08:08:13 INFO - Running setup.py install for mozhttpd 08:08:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozinfo 08:08:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozInstall 08:08:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozleak 08:08:14 INFO - Running setup.py install for mozlog 08:08:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for moznetwork 08:08:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozprocess 08:08:14 INFO - Running setup.py install for mozprofile 08:08:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozrunner 08:08:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:14 INFO - Running setup.py install for mozscreenshot 08:08:15 INFO - Running setup.py install for moztest 08:08:15 INFO - Running setup.py install for mozversion 08:08:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:15 INFO - Cleaning up... 08:08:15 INFO - Return code: 0 08:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:15 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')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:15 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 08:08:15 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 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:15 INFO - Running setup.py (path:/tmp/pip-Tz3LZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:15 INFO - Running setup.py (path:/tmp/pip-mLlIh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:15 INFO - Running setup.py (path:/tmp/pip-wi93ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:15 INFO - Running setup.py (path:/tmp/pip-wP0uFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:15 INFO - Running setup.py (path:/tmp/pip-iq9FV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:15 INFO - Running setup.py (path:/tmp/pip-RdjLAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:15 INFO - Running setup.py (path:/tmp/pip-mNVE8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:15 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)) 08:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:15 INFO - Running setup.py (path:/tmp/pip-JHAnCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:16 INFO - Running setup.py (path:/tmp/pip-TfRaLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:16 INFO - Running setup.py (path:/tmp/pip-YW13tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:16 INFO - Running setup.py (path:/tmp/pip-qfv0m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:16 INFO - Running setup.py (path:/tmp/pip-0NQoUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:16 INFO - Running setup.py (path:/tmp/pip-_qd6zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:16 INFO - Running setup.py (path:/tmp/pip-_pHFJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:16 INFO - Running setup.py (path:/tmp/pip-LA6aW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:16 INFO - Running setup.py (path:/tmp/pip-NJw47F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:16 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)) 08:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:16 INFO - Running setup.py (path:/tmp/pip-hfgofL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 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)) 08:08:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:16 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 08:08:18 INFO - Downloading blessings-1.6.tar.gz 08:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:18 INFO - Installing collected packages: blessings 08:08:18 INFO - Running setup.py install for blessings 08:08:18 INFO - Successfully installed blessings 08:08:18 INFO - Cleaning up... 08:08:18 INFO - Return code: 0 08:08:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:19 INFO - Reading from file tmpfile_stdout 08:08:19 INFO - Current package versions: 08:08:19 INFO - argparse == 1.2.1 08:08:19 INFO - blessings == 1.6 08:08:19 INFO - blobuploader == 1.2.4 08:08:19 INFO - docopt == 0.6.1 08:08:19 INFO - functools32 == 3.2.3-2 08:08:19 INFO - jsonschema == 2.5.1 08:08:19 INFO - manifestparser == 1.1 08:08:19 INFO - mozInstall == 1.12 08:08:19 INFO - mozcrash == 0.17 08:08:19 INFO - mozdebug == 0.1 08:08:19 INFO - mozdevice == 0.48 08:08:19 INFO - mozfile == 1.2 08:08:19 INFO - mozhttpd == 0.7 08:08:19 INFO - mozinfo == 0.9 08:08:19 INFO - mozleak == 0.1 08:08:19 INFO - mozlog == 3.2 08:08:19 INFO - moznetwork == 0.27 08:08:19 INFO - mozprocess == 0.22 08:08:19 INFO - mozprofile == 0.28 08:08:19 INFO - mozrunner == 6.11 08:08:19 INFO - mozscreenshot == 0.1 08:08:19 INFO - mozsystemmonitor == 0.3 08:08:19 INFO - moztest == 0.7 08:08:19 INFO - mozversion == 1.4 08:08:19 INFO - psutil == 3.1.1 08:08:19 INFO - requests == 1.2.3 08:08:19 INFO - wsgiref == 0.1.2 08:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 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 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:19 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 08:08:19 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 08:08:19 INFO - Using env: {'DISPLAY': ':0', 08:08:19 INFO - 'HOME': '/home/cltbld', 08:08:19 INFO - 'LANG': 'en_US.UTF-8', 08:08:19 INFO - 'LANGUAGE': 'en_US:en', 08:08:19 INFO - 'LOGNAME': 'cltbld', 08:08:19 INFO - 'MAIL': '/var/mail/cltbld', 08:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:19 INFO - 'MOZ_NO_REMOTE': '1', 08:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:19 INFO - 'NO_EM_RESTART': '1', 08:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:19 INFO - 'PWD': '/builds/slave/test', 08:08:19 INFO - 'SHELL': '/bin/bash', 08:08:19 INFO - 'SHLVL': '1', 08:08:19 INFO - 'TERM': 'linux', 08:08:19 INFO - 'TMOUT': '86400', 08:08:19 INFO - 'USER': 'cltbld', 08:08:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:19 INFO - '_': '/tools/buildbot/bin/python'} 08:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 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)) 08:08:19 INFO - Cleaning up... 08:08:19 INFO - Return code: 0 08:08:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:08:19 INFO - Using env: {'DISPLAY': ':0', 08:08:19 INFO - 'HOME': '/home/cltbld', 08:08:19 INFO - 'LANG': 'en_US.UTF-8', 08:08:19 INFO - 'LANGUAGE': 'en_US:en', 08:08:19 INFO - 'LOGNAME': 'cltbld', 08:08:19 INFO - 'MAIL': '/var/mail/cltbld', 08:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:19 INFO - 'MOZ_NO_REMOTE': '1', 08:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:19 INFO - 'NO_EM_RESTART': '1', 08:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:19 INFO - 'PWD': '/builds/slave/test', 08:08:19 INFO - 'SHELL': '/bin/bash', 08:08:19 INFO - 'SHLVL': '1', 08:08:19 INFO - 'TERM': 'linux', 08:08:19 INFO - 'TMOUT': '86400', 08:08:19 INFO - 'USER': 'cltbld', 08:08:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:19 INFO - '_': '/tools/buildbot/bin/python'} 08:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:08:19 INFO - Cleaning up... 08:08:19 INFO - Return code: 0 08:08:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53c68c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', '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 08:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:08:19 INFO - Using env: {'DISPLAY': ':0', 08:08:19 INFO - 'HOME': '/home/cltbld', 08:08:19 INFO - 'LANG': 'en_US.UTF-8', 08:08:19 INFO - 'LANGUAGE': 'en_US:en', 08:08:19 INFO - 'LOGNAME': 'cltbld', 08:08:19 INFO - 'MAIL': '/var/mail/cltbld', 08:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:19 INFO - 'MOZ_NO_REMOTE': '1', 08:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:19 INFO - 'NO_EM_RESTART': '1', 08:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:19 INFO - 'PWD': '/builds/slave/test', 08:08:19 INFO - 'SHELL': '/bin/bash', 08:08:19 INFO - 'SHLVL': '1', 08:08:19 INFO - 'TERM': 'linux', 08:08:19 INFO - 'TMOUT': '86400', 08:08:19 INFO - 'USER': 'cltbld', 08:08:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:19 INFO - '_': '/tools/buildbot/bin/python'} 08:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:19 INFO - Downloading/unpacking flake8 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:22 INFO - no previously-included directories found matching 'docs/_build' 08:08:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:22 INFO - Running setup.py install for pep8 08:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:22 INFO - no previously-included directories found matching 'docs/_build' 08:08:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:22 INFO - Cleaning up... 08:08:22 INFO - Return code: 0 08:08:22 INFO - Running post-action listener: _resource_record_post_action 08:08:22 INFO - Running post-action listener: _start_resource_monitoring 08:08:22 INFO - Starting resource monitoring. 08:08:22 INFO - ##### 08:08:22 INFO - ##### Finished create-virtualenv step (success) 08:08:22 INFO - ##### 08:08:22 INFO - ##### 08:08:22 INFO - ##### Running install step. 08:08:22 INFO - ##### 08:08:22 INFO - Running pre-action listener: _resource_record_pre_action 08:08:22 INFO - Running main action method: install 08:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:22 INFO - Reading from file tmpfile_stdout 08:08:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:22 INFO - Reading from file tmpfile_stdout 08:08:22 INFO - Output received: 08:08:22 INFO - Usage: mozinstall [options] installer 08:08:22 INFO - Options: 08:08:22 INFO - -h, --help show this help message and exit 08:08:22 INFO - -d DEST, --destination=DEST 08:08:22 INFO - Directory to install application into. [default: 08:08:22 INFO - "/builds/slave/test"] 08:08:22 INFO - --app=APP Application being installed. [default: firefox] 08:08:22 INFO - mkdir: /builds/slave/test/build/application 08:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:39 INFO - Reading from file tmpfile_stdout 08:08:39 INFO - Output received: 08:08:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:39 INFO - Running post-action listener: _resource_record_post_action 08:08:39 INFO - ##### 08:08:39 INFO - ##### Finished install step (success) 08:08:39 INFO - ##### 08:08:39 INFO - ##### 08:08:39 INFO - ##### Running run-tests step. 08:08:39 INFO - ##### 08:08:39 INFO - Running pre-action listener: _resource_record_pre_action 08:08:39 INFO - Running main action method: run_tests 08:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:40 INFO - Python 2.7.3 08:08:40 INFO - Return code: 0 08:08:40 INFO - grabbing minidump binary from tooltool 08:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846110>, '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 0x17b2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:40 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 08:08:40 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 08:08:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:08:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:40 INFO - Return code: 0 08:08:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:41 INFO - Return code: 0 08:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 08:08:41 INFO - Using env: {'DISPLAY': ':0', 08:08:41 INFO - 'HOME': '/home/cltbld', 08:08:41 INFO - 'LANG': 'en_US.UTF-8', 08:08:41 INFO - 'LANGUAGE': 'en_US:en', 08:08:41 INFO - 'LOGNAME': 'cltbld', 08:08:41 INFO - 'MAIL': '/var/mail/cltbld', 08:08:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:41 INFO - 'MOZ_NO_REMOTE': '1', 08:08:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:41 INFO - 'NO_EM_RESTART': '1', 08:08:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:41 INFO - 'PWD': '/builds/slave/test', 08:08:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:41 INFO - 'SHELL': '/bin/bash', 08:08:41 INFO - 'SHLVL': '1', 08:08:41 INFO - 'TERM': 'linux', 08:08:41 INFO - 'TMOUT': '86400', 08:08:41 INFO - 'USER': 'cltbld', 08:08:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755', 08:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:41 INFO - '_': '/tools/buildbot/bin/python'} 08:08:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:08:41 INFO - mozversion application_buildid: 20160621053017 08:08:41 INFO - mozversion application_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 08:08:41 INFO - mozversion application_display_name: Nightly 08:08:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:41 INFO - mozversion application_name: Firefox 08:08:41 INFO - mozversion application_remotingname: firefox 08:08:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:41 INFO - mozversion application_vendor: Mozilla 08:08:41 INFO - mozversion application_version: 50.0a1 08:08:41 INFO - mozversion platform_buildid: 20160621053017 08:08:41 INFO - mozversion platform_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 08:08:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:41 INFO - mozversion platform_version: 50.0a1 08:08:41 INFO - using testdate: 1466521721 08:08:41 INFO - actual date: 1466521721 08:08:41 INFO - starting webserver on 'localhost:43268' 08:08:41 INFO - SUITE-START | Running 2 tests 08:08:41 INFO - TEST-START | dromaeo_css 08:08:41 INFO - operating with platform_type : linux_ 08:08:41 INFO - Initialising browser for dromaeo_css test... 08:08:41 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDE7C68/profile http://localhost:43268/getInfo.html) 08:08:45 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 08:08:45 INFO - PROCESS | 3332 | colorDepth:24 08:08:45 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 08:08:45 INFO - PROCESS | 3332 | __metrics 08:08:47 INFO - PROCESS | 3332 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:48 INFO - TEST-INFO | 3332: exit 0 08:08:48 INFO - Browser initialized. 08:08:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:48 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDE7C68/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:00 INFO - PROCESS | 3418 | RSS: Main: 174288896 08:09:00 INFO - PROCESS | 3418 | 08:09:51 INFO - PROCESS | 3418 | 1466521791785 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] 08:11:59 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43268/tests/dromaeo/cssquery-ext.html) 08:12:00 INFO - PROCESS | 3418 | RSS: Main: 246169600 08:12:00 INFO - PROCESS | 3418 | 08:15:03 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-ext.html (next: http://localhost:43268/tests/dromaeo/cssquery-jquery.html) 08:15:03 INFO - PROCESS | 3418 | RSS: Main: 265461760 08:15:03 INFO - PROCESS | 3418 | 08:18:05 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43268/tests/dromaeo/cssquery-mootools.html) 08:18:06 INFO - PROCESS | 3418 | RSS: Main: 253177856 08:18:06 INFO - PROCESS | 3418 | 08:21:08 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43268/tests/dromaeo/cssquery-prototype.html) 08:21:09 INFO - PROCESS | 3418 | RSS: Main: 256450560 08:21:09 INFO - PROCESS | 3418 | 08:24:11 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43268/tests/dromaeo/cssquery-yui.html) 08:24:12 INFO - PROCESS | 3418 | RSS: Main: 239357952 08:24:12 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:43268/tests/dromaeo/cssquery-yui.html (next: http://localhost:43268/tests/dromaeo/cssquery-dojo.html) 08:27:15 INFO - PROCESS | 3418 | RSS: Main: 289398784 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | __start_tp_report 08:27:15 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 08:27:15 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 08:27:15 INFO - PROCESS | 3418 | |i|pagename|runs| 08:27:15 INFO - PROCESS | 3418 | |0;dojo.html;3047.101105173972;3052.572639830424;3061.78567500275;3084.8611812468434;3103.7516998640112;5030.949690503094;5121.052605268019;5127.820526281581;5193.428722840485;5240.633155679099;5160.380754309488;5162.716050617215;5173.974130129353;5215.191645294976;5248.448912864152;4653.418322709661;4702.929456058162;4746.620270378378;4791.952080479203;4938.358013458245;4820.445648750386;4846.151923413388;4864.075825593126;4900.558949694527;4921.680090794087;4622.722636641795;4640.60554852838;4647.32613771003;4700.2949557566635;4705.12955103307;4714.175019371596;4728.1252968201;4729.077829823186;4797.856064318076;4835.806567737286;4765.237561990065;4780.450248221464;4792.209285467929;4799.2321228603605;4843.443004054544;4967.82612608557;5039.748012599392;5150.201718733565;5217.58259339252;5219.164933610642;5565.193047008162;5594.552435805126;5621.156826476021;5654.264945557093;5657.8585535361535;5647.689377084259;5658.0381335173115;5678.545716342683;5705.2012718219485;5706.172604972297;5045.722485263309;5176.456472070454;5240.68555886648;5243.632945693803;5313.043652142652;5775.48020678141;5785.768569257182;5786.942130578725;5788.681622510718;5790.044642633919;5267.9736601316745;5566;5575.303087114111;5585.273914391184;5587.888242235133;5520.972395137998;5547.611667183339;5571.693556854412;5574.470425309589;5633.957717822216;5544.085225937675;5555.111182210827;5555.416681248492;5555.611107222456;5567.498925096761;5372.973135134299;5527.751251193626;5554.472325129106;5565.30433695788;5644.096944488944;4280.079782846703;4287.485501739811;4287.6355509782015;4325.545817689161;4334.306510958231;3871.709621778378;3873.9418908716393;3888.727789054739;3899.317619416591;3922.490076290064;5210.739463026834;5334.466553344634;5337.893242135136;5355;5363.624546281801;5637.774489020475;5684.147377893267;5697.715114244271;5701.942980570141;5757.453041961007;5433.130699088127;5444.373897001896;5445.128779395278;5447.782088716486;5451.2640793493165;4774.785134668949;4882.194437917704;4901.779419926112;4969.27945447908;5023.447420783711;5944.464998150187;5947.988841896974;5956.970215148983;5961.672108034013;5998.3701711320555;5663.235463212413;5675.517581005661;5677.602567820213;5681.17622944679;5682.261306030189;5656.943430565641;5779.0464573344925;5815.273090863642;5834.03738383179;5950.821475355746;5483.5064844162625;5498.972505137449;5500.339959204921;5502.9174562380795;5507.752151153128;5540.335159780852;5586.329640443173;5587.776488940397;5588.804391846266;5615.241942337732;5240.109181439088;5340.652857564246;5360.410354860885;5389.568834493152;5433.945660543344;5423.3491980962535;5424.1321388577635;5427.701476418835;5428.050091234098;5428.972855135699;5212.061828870688;5318.627696061239;5325.893482130413;5343.679379237258;5390.676559406448;5295.576353891603;5380.408155102858;5404.486573775485;5418.160185171305;5433.538149257357;5379.435159308373;5399.865003374947;5412.9174165167915;5413.296271484682;5414.485623865727 08:27:15 INFO - PROCESS | 3418 | |1;ext.html;595.731920635714;600.5285850607277;610.8442347201463;616.4359610955976;632.8924082905907;30300.696993030062;30689.386212275742;42340.36489452657;42831.14337713244;42922.570774292246;40247.79876100623;44828;44963.77518112413;44998;45143.322850157274;8817.86773198401;9000.684976025841;9006.864897026517;9007.234385077243;9008.819823603524;8815.77960550985;8920.776980575505;8921.598528066253;8924.107589241088;8924.241439477652;8938.776530586721;8951.283897288235;8987.281017518582;8988.550572471382;8995.235404990584;8907.955460222689;8935.776605584848;8953.462792232487;8955.19403253707;8962.283017358628;8787.340949428755;8845.159709827556;8863.867041994376;8867.379283450162;8874.201321880997;42111.57888421107;42162.78918605418;42410.36384454236;42435.57564424347;42477.78761106206;3808.6953043756434;3826;4111.198316328318;4287.164003019381;4369.563043695637;32841.50737738936;32944.505832412295;33397.499037514455;33470.564836913334;33838.66161338404;4320.82716691332;4327.697061205717;4357.760323182224;4386.407834942273;4457.04173602677;363936;364987.9999999973;365621;366082;366781;55873.72063139658;56157;56310;56351;56603.71698141565;59027.40972590305;59120;59143.268538516815;59223.446593203684;59409.40590594039;13420.731585368238;14877.776833347509;15329.923350383177;15388.30752616135;16080.517584472485;11987.520499179935;12050.819237711266;12076.577319793765;12095;12096;14498.710025799424;15873.603159921095;15937.282822273026;16028.919855400649;16047.117408542643;6531.412172904462;6838.316168383122;6880.759173429006;6892.517523773287;6964.93035069653;930.7161315798746;1053.7471006958428;1057.2282233969092;1107.6289443036512;1111.1000089927024;32160.19599510031;32161.356772864412;32589.87351873266;32606;32865.67134328626;1085.2511766880828;1110.6945589962825;1129.2264798612975;1181.6691326428613;1214.271437137728;16836.83163168377;17219.311227551007;17272.22274997603;17364.131793410277;17369.392071277445;492861;494241;498547;498847;498973.5051324793;58594.41405585975;58854.7057264711;58861.117083243786;58915;58944.11583826246;1325.158524337053;1363.6727185475613;1375.6148278482042;1379.5309594737637;1380.8481067082612;30883.84558077195;31452.370952580364;31987.360252794348;32210.355792883543;32700;51294;51585.74207129091;51738;51754.223686645484;51773.741131294104;417048;422710;426244;426452;431728;34676.13309667177;39654;40573;40952;41563.96090097772;48517.75741121272;48889;49167;50150.74924625499;50290.74854625703;40747;41174;41262.79368603138;42756.78621606872;42959.78520107379;40455.393169101895;40582.93614154239;40951.38572921468;41511.37732933948;41741.37387939244;40506.39240411337;41222.79388603038;41244.79377603093;41503.7924810374;41766.1646767069;35105.64894351024;37054.44418333673;37583;37649;37933.62066379301;27160.456790863678;27824.16527504178;27838.304042398293;27917.860410697816;28174.85912570424 08:27:15 INFO - PROCESS | 3418 | |2;jquery.html;386.4184402474274;386.7018093886453;386.8820009896982;397.31264911702755;416.29853696521366;14403.423863045466;16041.839581604181;18036;19644.705329420052;19649.31227407041;18366.908165459186;19318.61362772747;19580.314688985887;19582.70625940612;19655.410337689857;5625.240592520019;5646.717664116798;5685.260916080903;5738.081906894898;5778.248827652399;4102.958970410287;5675.063614503602;5701.971490142543;5743.425657434265;6172.9074063889075;6443.033544968245;6487.902681459782;6518.152640156797;6579.703913323888;6579.93420065798;6357.841053973688;6433.774817881375;6477.870442591146;6526.053722210277;6541.443977261938;5691.601587888849;5755.338136114358;5760.711964401805;5770.7691692332255;5788.42115788422;21616.675749863763;21982.89008554963;22608.54782904349;22615.208467703716;22766.65850012251;2529.6332031855463;2602.869856507186;2802.5604128417563;3067.1871953932227;3083.321669232765;13189;13909.165450072927;14162.433502659984;14531.128132312095;14654.926725366411;1855.2857149997212;1879.1262063140568;1879.5348374912921;1929.9807001929942;1987.49318923675;79462.20537794664;80211.19788802095;81243;82489.58755206186;84239.57880210559;10853.643294588177;10962.725931851608;10996.725081873017;11024;11094.55621775136;13240.602781916557;13659.453621855015;15301.540953771404;15366.154861482502;15371.38514459409;7517.511361761577;7744.380449564022;7749.302562769378;7778.327659553223;7939.523628582304;7214;7294.343509084208;7331.853362932711;7449.925500744923;7522;4663.393758811333;4682.672212945061;4718.900089460226;4751.382320298409;4822.469528351879;1954.5699946011855;1990.7212990181386;1996.780354161041;1998.2506560039985;2010.8793472391703;883.571467838098;983.3804703037041;1036.5801850250662;1041.1046500009986;1093.0981939899614;18199.363022294157;18520;18817.15322810477;18880.43358699241;19165.32921347746;927.1794461901266;949.6296444386695;970.8252514547308;976.2824324121765;979;10332;10643.84034239487;10715.892841071489;10758.0855627271;10778.838317425088;454158;461915;462799;469612;473405;92066.53966730123;95317;95559.52220238854;96030;97157;948.7343543807744;962.1100482054072;963.7879666473365;972.5526257921294;981.1218959031627;16700;16881.155942203088;16899.91550042242;16900;17110.315587376364;30356.696433035388;38684.226315474094;40130.598694013854;40274.1945161101;42325.57674423217;51131;52792;53899.46100538944;54072.72963635314;54084.72957635186;8220.465669731448;8245.628946697292;8434.451760635538;8479.024912135183;8573.91426085756;9274.814503709753;11101.667799864068;12695.238285702888;13099.083064185797;13681.657958550717;8053.557054362066;11497.08023358146;11595.536178552764;11973.16187866841;11994.820077699016;11799.410029498318;11904.821427678766;11929.46317415701;12044.036477081987;12224.69438264015;11745.941270293593;11776.528938842694;12029.699257518632;12149.75700486003;12173.20874143178;7428;7549.131849837119;8506.914930850613;8581.613827377907;8742;6040.909386359121;8059.758207253792;11689.298642081163;11695.532178712756;11838.408079596158 08:27:15 INFO - PROCESS | 3418 | |3;mootools.html;1276.0875973678828;1458.5843034735103;1480.3190532355115;1604.8796340274475;1739.5042412912323;7692.961535192323;8003.119656837744;8030.478018928773;8207.05618853832;8212.425130240885;7936.880946785788;8099.757007289776;8110.067342255642;8113.391495637836;8113.756587302376;1984.1864835417482;2204.834637402193;2278.7949084582424;2292.713410823647;2304.412374844421;2284.908603655852;2290.1640901071073;2293.655951607264;2296.552172326397;2299.655051742235;2275.215050807477;2281.281396360141;2314.3866875278063;2318.014843691433;2320.512692334612;1898.069945726591;2151.7740637233023;2228.0864845413466;2234.240358278177;2237.7090978172896;2220.222921977311;2229.0749339024287;2254.2673631069806;2261.8416710830247;2262.479629685165;8195.46729462589;8304.128066552985;8313.916860831374;8318.8336233275;8322.45904016237;4852.927206091911;4976.950230497685;4984.102861484931;4988.0023995200745;4988.376452943382;2991.3718119194996;3172.6034245719284;3180.2685382361956;3205.214722393005;3219.7585181111513;1137.2266858536193;1138.9658310250707;1152.2913408253864;1157.589055885157;1175.400545721688;10916.508757106028;10931.672049838518;10971.615993440191;10982.725431864188;10988.890111098866;4170.854020109282;4261.190373828963;4336.848210312687;4361.171377438277;4373.606375426227;9315.580798864068;9353.39202951806;9355.158035776813;9358.53207339644;9360.344775865624;4898.853034408973;4899.5590396863745;4900.877478063006;4905.166121759309;4907.1903135982875;4003.199360127986;4396.230659634615;4529.728216307032;4540.2054640438455;4594.287885377772;3741.345264578688;3792.469054332396;3832.865849695247;3852.768833869977;3892.8832135035996;1219.6950762309423;1260.8991280697521;1269.650846017334;1277.6550331410467;1280.9103362764704;925.8472352061834;979.9314048016571;980.54404701814;1005.6329439754584;1022.1414012229762;5877.294724633071;5973.163757074013;6007.249093863267;6074.969625151934;6081.787137450168;446.2035267048303;456.6734784629006;467.0728603721678;990.5195979949718;1075.231209685079;4161.91676166475;4211.7262377945335;4235.470566179228;4278.529361770203;4307.784610769449;9797.657082002095;10056.899431005742;10183.33808302458;10187.439690816927;10191.082802547659;10043.748906277255;10048.49757512136;10069.54687039085;10073.848892266622;10081.344712593658;7217.2421895701245;7584.62076896153;7704.807379815549;7805.843883122306;7825.530468171814;5919.230500034968;5931.466168044896;5959.314678811992;6123.908141377972;6141.324454309933;8702.434341767765;9107.772305692411;9125.269978401579;9295.76760580991;9388.248940084914;8870.42342247752;9305.20905722994;9320;9341.859872102059;9348.252139828934;6963.373296403348;7571.886421703569;7629.580373079534;7867.960660196892;8023.759287221393;8096.271335579826;8103.554304513308;8126.756197313854;8164.5917704115745;8171.509709417454;6812.318768123148;7256.7097316106765;7391.741289055072;7430.108386993596;7476.476646634684;7158;7324.230955749783;7326.3040011198855;7336.889946650697;7382.2617738225745;6754.696038678369;6824.249332573512;6831.726730930707;6832.043513907957;6834.179898412222;5026.824061157842;5082.136036873666;5084.745762711776;5144.331236939174;5187.24784906179;5112.028714544224;5141.434442211279;5175.327207463006;5202.375714914235;5235.136202526541 08:27:15 INFO - PROCESS | 3418 | |4;prototype.html;292.42246563038015;301.37765514213146;308.9289463423413;309.22847495498735;310.91916101813536;5107.38711354638;5246.134387826009;5250.501202385777;5303.734813259341;5307.097793375126;5177.482251774821;5244.370675518933;5250.159974404087;5252.293004773454;5279.5512381447625;4062.3500239961613;4065.9022064042692;4093.0995181060193;4111.897202569945;4150.688698347621;3862.86479973201;3883.8446462141483;4111.979440102796;4118.238125946695;4146;4028.952472357179;4047.170330082326;4076.9184616307657;4080.5919408059253;4083.5099788025477;4034.293998550242;4049.068714195737;4071.1247081877536;4075.2868248056766;4083.3670781028986;3509.7543171977973;3600.0999750062483;3617.4573813928123;3623.40213864712;3627.8209581885994;5028.723420211887;5040.899182016376;5050.141475949061;5068.5691716204165;5142.331496905415;4598.195315819752;4621.74580398078;4625.726671594385;4660.324252983332;4675.602573781232;5248.973755131238;5405.675659460445;5442.591805614595;5451.127819548853;5478.726063696799;3848.8845334640005;3886.650201481852;3888.786116763577;3895.1692704428874;3924.0189952511873;5566.248556444869;5581.190727344512;5630.746616402272;5637.58925849859;5652.943470565324;3965.9490235087724;3966.3852102924093;3973.1854969731135;3993.4009898514873;4030.435738996543;3945.8421663133727;4036.2734707752297;4042.3734321180264;4043.130726893673;4045;4526.140033393644;4530.97734511332;4532.660050496226;4590.403247577793;4614.661748093083;5422.8373148805595;5432.837014889559;5457.508824205841;5466.316710411199;5470.480304371078;1293.767121918045;1338.7683331335195;1407.366684991758;1419.233613848531;1419.5102689572082;874.6107981947972;895.4806212396794;904.3172404834309;906.2976193450129;910.7905181808221;4786.803299175206;4800.855974320776;4825.95174048262;4883.243097319921;4916.385451818523;4893.6329775266995;4945.55490005894;4952.925706114411;4979.30289759434;4984.451710311862;4529.433820772403;4774.40319960005;4790.808367665254;4793.664443488922;4808.807647694053;2646.491499845108;2655.349439387324;2673.26485216567;2677.6920654124638;2682.973170268311;5186.299849520342;5212.582993360522;5225.503577160163;5225.790968361299;5296.390915044819;4824.469308376076;4992.803166606682;5024.397072351341;5039.496050394931;5044.672096313728;5137.768800403991;5155.407128180233;5168.095583272912;5268.973655131853;5294.23233631129;4958.264607387529;5014.724190169576;5028.245763135559;5040.908023170343;5061.468545802638;4646.0486595629245;4925.87207123472;4944.887400334896;4956.529129732669;4980.750962451935;5096.23556466533;5165.354330708661;5183.870403239949;5210.244514545446;5234.7906083756225;3656.1956369598647;3666.4133738601695;3677.1206377272233;3746.4754934309763;3900.687944964453;5160.612954028388;5210.5831533477985;5509.614326997232;5530.419305972976;5576.888462230814;5359.839204823861;5384.300040994645;5445.618806683494;5461.481159289861;5529.391766905717;5365.22204280385;5413.24214609947;5439.782408703608;5474.972625137008;5482.479164479368;5279.920801187908;5350.705711185767;5377.3816011159215;5382.919256211082;5429;5473.890522189454;5481.725913704219;5493.23094766725;5494.077073024409;5533.280673512418;5349.619419358503;5355.785768569213;5360.142377219626;5369.570434365163;5407.324084489439 08:27:15 INFO - PROCESS | 3418 | |5;yui.html;705.6189657584904;712.8253577873422;730.5470608222903;732.3335764454348;749.9212582678819;14977.850221497796;15821.288042038108;15825.84174158258;16013.599660008505;16403.179841007946;14803.851961480383;14830.777538336934;14944.701105977874;14976;14993.47522836701;659.967001649918;776.4448419380142;806.6732973145886;823.0493779684474;831.5010993403939;822.786075620337;823.1932705948144;825.8183199696088;826.0665448043702;826.89663792026;862.1464749897588;862.5644049754865;863.2791618998144;863.9308855291594;863.9913600864005;687.5977553131399;798.3732769775727;862.0345213361076;865.4763867859917;866.1987661413231;632.4213344789558;633.5470138850744;633.727497176214;633.7718421368304;633.9587926784744;14479.42082316706;14676.926615366961;14699.19154446505;14734.70530589393;14735.55793326202;13960.441582336694;14017.789733154012;14083.225422601752;14105.858941410557;14261.358238879171;12705.237685738884;12712.555060572928;12858.164219325714;13026.934865325708;13046.478140874353;4252.87241382759;4272.1028583997395;4317.11499142675;4369.715968462072;4399.274119770234;69543;69654;69979.30020699778;70046.99999999949;70251.2974870255;11388.772224555463;11389.202755807013;11446.771064578828;11459.48432320531;11503.53985840557;18883.150258238136;18902.432927011938;18906.905465472584;18918.43244702661;18963.715544266848;7853.764387068397;7864.174261702439;8276.958615206886;8399.664013439517;8500.574971251413;4600.539946005372;4629.65277604181;4671.6262698984;4682.297655351725;4796.112719146969;3362.9327413451592;3478.9478157827652;3479.59984601774;3480.2691434798976;3491.94762078569;621.6580880515698;627.3788948940517;627.4290395739855;642.4442856928723;646.4731244036095;602.2802750712856;685.1196212866442;687.4878215729213;714.9964250178716;718.4934621092118;9552.90447095534;9560.330776845554;9569.61721531131;9634.518274086407;9673.516324183762;592.5792687192055;606.9059295809157;633.9856230032004;665.4377051391566;696.7073828991836;4482.372467854503;4636.258198688193;4678.812847486062;4719.2921061841;4816.4220293564995;107211.46394267978;108814;109053;113224;113734.43132784283;96321;96494.9999999986;96810.51594741982;97237;98002;83780.58109709412;84395.57802210949;84834;85312;85862.57068714492;8682.609282582425;8691.608877600649;8756.649734010569;8810.823783524422;8872.689455869013;48744.0251194967;50621.49378506168;51069.74465127651;51130.277526605765;52181.21728174004;45208.32187517124;45795.542044579124;46116.53883461122;63802.68098659477;66932.33067669456;12858.228506289652;13697.452101915811;13712.108712933627;13747.725045499234;13932.651683707989;8130.715424960098;14448.783268250774;15003.2498375083;15005.32476038559;15052.698946021237;13995.072717157876;14306.427742890168;14691.41234350614;14801.851981480047;14935.327910243848;13718.93140534291;14053.508127215498;14130;14440.494582689555;14472.638184045483;13932.373043213283;14279.286035698382;14288.57134285973;14594.781078283622;14633.122012679274;10845.511951962022;11063.446827658423;11113.277636953571;11306.208565400342;11951.581694640647;11178.496967636313;11768.228776763262;12141.816415735751;12352.62942111738;12390 08:27:15 INFO - PROCESS | 3418 | __end_tp_report 08:27:15 INFO - PROCESS | 3418 | __start_cc_report 08:27:15 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,939 08:27:15 INFO - PROCESS | 3418 | __end_cc_report 08:27:15 INFO - PROCESS | 3418 | __startTimestamp1466522835374__endTimestamp 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | ------- Summary: start ------- 08:27:15 INFO - PROCESS | 3418 | Number of tests: 6 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#0] dojo.html Cycles:165 Average:5206.78 Median:5389.57 stddev:587.08 (10.9%) stddev-sans-first:563.90 08:27:15 INFO - PROCESS | 3418 | Values: 3047.1 3052.6 3061.8 3084.9 3103.8 5030.9 5121.1 5127.8 5193.4 5240.6 5160.4 5162.7 5174.0 5215.2 5248.4 4653.4 4702.9 4746.6 4792.0 4938.4 4820.4 4846.2 4864.1 4900.6 4921.7 4622.7 4640.6 4647.3 4700.3 4705.1 4714.2 4728.1 4729.1 4797.9 4835.8 4765.2 4780.5 4792.2 4799.2 4843.4 4967.8 5039.7 5150.2 5217.6 5219.2 5565.2 5594.6 5621.2 5654.3 5657.9 5647.7 5658.0 5678.5 5705.2 5706.2 5045.7 5176.5 5240.7 5243.6 5313.0 5775.5 5785.8 5786.9 5788.7 5790.0 5268.0 5566.0 5575.3 5585.3 5587.9 5521.0 5547.6 5571.7 5574.5 5634.0 5544.1 5555.1 5555.4 5555.6 5567.5 5373.0 5527.8 5554.5 5565.3 5644.1 4280.1 4287.5 4287.6 4325.5 4334.3 3871.7 3873.9 3888.7 3899.3 3922.5 5210.7 5334.5 5337.9 5355.0 5363.6 5637.8 5684.1 5697.7 5701.9 5757.5 5433.1 5444.4 5445.1 5447.8 5451.3 4774.8 4882.2 4901.8 4969.3 5023.4 5944.5 5948.0 5957.0 5961.7 5998.4 5663.2 5675.5 5677.6 5681.2 5682.3 5656.9 5779.0 5815.3 5834.0 5950.8 5483.5 5499.0 5500.3 5502.9 5507.8 5540.3 5586.3 5587.8 5588.8 5615.2 5240.1 5340.7 5360.4 5389.6 5433.9 5423.3 5424.1 5427.7 5428.1 5429.0 5212.1 5318.6 5325.9 5343.7 5390.7 5295.6 5380.4 5404.5 5418.2 5433.5 5379.4 5399.9 5412.9 5413.3 5414.5 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#1] ext.html Cycles:180 Average:59349.25 Median:232436.39 stddev:114317.74 (49.2%) stddev-sans-first:114553.32 08:27:15 INFO - PROCESS | 3418 | Values: 595.7 600.5 610.8 616.4 632.9 30300.7 30689.4 42340.4 42831.1 42922.6 40247.8 44828.0 44963.8 44998.0 45143.3 8817.9 9000.7 9006.9 9007.2 9008.8 8815.8 8920.8 8921.6 8924.1 8924.2 8938.8 8951.3 8987.3 8988.6 8995.2 8908.0 8935.8 8953.5 8955.2 8962.3 8787.3 8845.2 8863.9 8867.4 8874.2 42111.6 42162.8 42410.4 42435.6 42477.8 3808.7 3826.0 4111.2 4287.2 4369.6 32841.5 32944.5 33397.5 33470.6 33838.7 4320.8 4327.7 4357.8 4386.4 4457.0 363936.0 364988.0 365621.0 366082.0 366781.0 55873.7 56157.0 56310.0 56351.0 56603.7 59027.4 59120.0 59143.3 59223.4 59409.4 13420.7 14877.8 15329.9 15388.3 16080.5 11987.5 12050.8 12076.6 12095.0 12096.0 14498.7 15873.6 15937.3 16028.9 16047.1 6531.4 6838.3 6880.8 6892.5 6964.9 930.7 1053.7 1057.2 1107.6 1111.1 32160.2 32161.4 32589.9 32606.0 32865.7 1085.3 1110.7 1129.2 1181.7 1214.3 16836.8 17219.3 17272.2 17364.1 17369.4 492861.0 494241.0 498547.0 498847.0 498973.5 58594.4 58854.7 58861.1 58915.0 58944.1 1325.2 1363.7 1375.6 1379.5 1380.8 30883.8 31452.4 31987.4 32210.4 32700.0 51294.0 51585.7 51738.0 51754.2 51773.7 417048.0 422710.0 426244.0 426452.0 431728.0 34676.1 39654.0 40573.0 40952.0 41564.0 48517.8 48889.0 49167.0 50150.7 50290.7 40747.0 41174.0 41262.8 42756.8 42959.8 40455.4 40582.9 40951.4 41511.4 41741.4 40506.4 41222.8 41244.8 41503.8 41766.2 35105.6 37054.4 37583.0 37649.0 37933.6 27160.5 27824.2 27838.3 27917.9 28174.9 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#2] jquery.html Cycles:180 Average:28081.71 Median:40202.40 stddev:76760.70 (190.9%) stddev-sans-first:76947.87 08:27:15 INFO - PROCESS | 3418 | Values: 386.4 386.7 386.9 397.3 416.3 14403.4 16041.8 18036.0 19644.7 19649.3 18366.9 19318.6 19580.3 19582.7 19655.4 5625.2 5646.7 5685.3 5738.1 5778.2 4103.0 5675.1 5702.0 5743.4 6172.9 6443.0 6487.9 6518.2 6579.7 6579.9 6357.8 6433.8 6477.9 6526.1 6541.4 5691.6 5755.3 5760.7 5770.8 5788.4 21616.7 21982.9 22608.5 22615.2 22766.7 2529.6 2602.9 2802.6 3067.2 3083.3 13189.0 13909.2 14162.4 14531.1 14654.9 1855.3 1879.1 1879.5 1930.0 1987.5 79462.2 80211.2 81243.0 82489.6 84239.6 10853.6 10962.7 10996.7 11024.0 11094.6 13240.6 13659.5 15301.5 15366.2 15371.4 7517.5 7744.4 7749.3 7778.3 7939.5 7214.0 7294.3 7331.9 7449.9 7522.0 4663.4 4682.7 4718.9 4751.4 4822.5 1954.6 1990.7 1996.8 1998.3 2010.9 883.6 983.4 1036.6 1041.1 1093.1 18199.4 18520.0 18817.2 18880.4 19165.3 927.2 949.6 970.8 976.3 979.0 10332.0 10643.8 10715.9 10758.1 10778.8 454158.0 461915.0 462799.0 469612.0 473405.0 92066.5 95317.0 95559.5 96030.0 97157.0 948.7 962.1 963.8 972.6 981.1 16700.0 16881.2 16899.9 16900.0 17110.3 30356.7 38684.2 40130.6 40274.2 42325.6 51131.0 52792.0 53899.5 54072.7 54084.7 8220.5 8245.6 8434.5 8479.0 8573.9 9274.8 11101.7 12695.2 13099.1 13681.7 8053.6 11497.1 11595.5 11973.2 11994.8 11799.4 11904.8 11929.5 12044.0 12224.7 11745.9 11776.5 12029.7 12149.8 12173.2 7428.0 7549.1 8506.9 8581.6 8742.0 6040.9 8059.8 11689.3 11695.5 11838.4 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#3] mootools.html Cycles:180 Average:5468.34 Median:4942.07 stddev:3001.04 (60.7%) stddev-sans-first:2992.92 08:27:15 INFO - PROCESS | 3418 | Values: 1276.1 1458.6 1480.3 1604.9 1739.5 7693.0 8003.1 8030.5 8207.1 8212.4 7936.9 8099.8 8110.1 8113.4 8113.8 1984.2 2204.8 2278.8 2292.7 2304.4 2284.9 2290.2 2293.7 2296.6 2299.7 2275.2 2281.3 2314.4 2318.0 2320.5 1898.1 2151.8 2228.1 2234.2 2237.7 2220.2 2229.1 2254.3 2261.8 2262.5 8195.5 8304.1 8313.9 8318.8 8322.5 4852.9 4977.0 4984.1 4988.0 4988.4 2991.4 3172.6 3180.3 3205.2 3219.8 1137.2 1139.0 1152.3 1157.6 1175.4 10916.5 10931.7 10971.6 10982.7 10988.9 4170.9 4261.2 4336.8 4361.2 4373.6 9315.6 9353.4 9355.2 9358.5 9360.3 4898.9 4899.6 4900.9 4905.2 4907.2 4003.2 4396.2 4529.7 4540.2 4594.3 3741.3 3792.5 3832.9 3852.8 3892.9 1219.7 1260.9 1269.7 1277.7 1280.9 925.8 979.9 980.5 1005.6 1022.1 5877.3 5973.2 6007.2 6075.0 6081.8 446.2 456.7 467.1 990.5 1075.2 4161.9 4211.7 4235.5 4278.5 4307.8 9797.7 10056.9 10183.3 10187.4 10191.1 10043.7 10048.5 10069.5 10073.8 10081.3 7217.2 7584.6 7704.8 7805.8 7825.5 5919.2 5931.5 5959.3 6123.9 6141.3 8702.4 9107.8 9125.3 9295.8 9388.2 8870.4 9305.2 9320.0 9341.9 9348.3 6963.4 7571.9 7629.6 7868.0 8023.8 8096.3 8103.6 8126.8 8164.6 8171.5 6812.3 7256.7 7391.7 7430.1 7476.5 7158.0 7324.2 7326.3 7336.9 7382.3 6754.7 6824.2 6831.7 6832.0 6834.2 5026.8 5082.1 5084.7 5144.3 5187.2 5112.0 5141.4 5175.3 5202.4 5235.1 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#4] prototype.html Cycles:180 Average:4429.68 Median:4982.60 stddev:1280.28 (25.7%) stddev-sans-first:1245.65 08:27:15 INFO - PROCESS | 3418 | Values: 292.4 301.4 308.9 309.2 310.9 5107.4 5246.1 5250.5 5303.7 5307.1 5177.5 5244.4 5250.2 5252.3 5279.6 4062.4 4065.9 4093.1 4111.9 4150.7 3862.9 3883.8 4112.0 4118.2 4146.0 4029.0 4047.2 4076.9 4080.6 4083.5 4034.3 4049.1 4071.1 4075.3 4083.4 3509.8 3600.1 3617.5 3623.4 3627.8 5028.7 5040.9 5050.1 5068.6 5142.3 4598.2 4621.7 4625.7 4660.3 4675.6 5249.0 5405.7 5442.6 5451.1 5478.7 3848.9 3886.7 3888.8 3895.2 3924.0 5566.2 5581.2 5630.7 5637.6 5652.9 3965.9 3966.4 3973.2 3993.4 4030.4 3945.8 4036.3 4042.4 4043.1 4045.0 4526.1 4531.0 4532.7 4590.4 4614.7 5422.8 5432.8 5457.5 5466.3 5470.5 1293.8 1338.8 1407.4 1419.2 1419.5 874.6 895.5 904.3 906.3 910.8 4786.8 4800.9 4826.0 4883.2 4916.4 4893.6 4945.6 4952.9 4979.3 4984.5 4529.4 4774.4 4790.8 4793.7 4808.8 2646.5 2655.3 2673.3 2677.7 2683.0 5186.3 5212.6 5225.5 5225.8 5296.4 4824.5 4992.8 5024.4 5039.5 5044.7 5137.8 5155.4 5168.1 5269.0 5294.2 4958.3 5014.7 5028.2 5040.9 5061.5 4646.0 4925.9 4944.9 4956.5 4980.8 5096.2 5165.4 5183.9 5210.2 5234.8 3656.2 3666.4 3677.1 3746.5 3900.7 5160.6 5210.6 5509.6 5530.4 5576.9 5359.8 5384.3 5445.6 5461.5 5529.4 5365.2 5413.2 5439.8 5475.0 5482.5 5279.9 5350.7 5377.4 5382.9 5429.0 5473.9 5481.7 5493.2 5494.1 5533.3 5349.6 5355.8 5360.1 5369.6 5407.3 08:27:15 INFO - PROCESS | 3418 | 08:27:15 INFO - PROCESS | 3418 | [#5] yui.html Cycles:180 Average:19799.44 Median:4653.94 stddev:28081.38 (603.4%) stddev-sans-first:28123.55 08:27:15 INFO - PROCESS | 3418 | Values: 705.6 712.8 730.5 732.3 749.9 14977.9 15821.3 15825.8 16013.6 16403.2 14803.9 14830.8 14944.7 14976.0 14993.5 660.0 776.4 806.7 823.0 831.5 822.8 823.2 825.8 826.1 826.9 862.1 862.6 863.3 863.9 864.0 687.6 798.4 862.0 865.5 866.2 632.4 633.5 633.7 633.8 634.0 14479.4 14676.9 14699.2 14734.7 14735.6 13960.4 14017.8 14083.2 14105.9 14261.4 12705.2 12712.6 12858.2 13026.9 13046.5 4252.9 4272.1 4317.1 4369.7 4399.3 69543.0 69654.0 69979.3 70047.0 70251.3 11388.8 11389.2 11446.8 11459.5 11503.5 18883.2 18902.4 18906.9 18918.4 18963.7 7853.8 7864.2 8277.0 8399.7 8500.6 4600.5 4629.7 4671.6 4682.3 4796.1 3362.9 3478.9 3479.6 3480.3 3491.9 621.7 627.4 627.4 642.4 646.5 602.3 685.1 687.5 715.0 718.5 9552.9 9560.3 9569.6 9634.5 9673.5 592.6 606.9 634.0 665.4 696.7 4482.4 4636.3 4678.8 4719.3 4816.4 107211.5 108814.0 109053.0 113224.0 113734.4 96321.0 96495.0 96810.5 97237.0 98002.0 83780.6 84395.6 84834.0 85312.0 85862.6 8682.6 8691.6 8756.6 8810.8 8872.7 48744.0 50621.5 51069.7 51130.3 52181.2 45208.3 45795.5 46116.5 63802.7 66932.3 12858.2 13697.5 13712.1 13747.7 13932.7 8130.7 14448.8 15003.2 15005.3 15052.7 13995.1 14306.4 14691.4 14801.9 14935.3 13718.9 14053.5 14130.0 14440.5 14472.6 13932.4 14279.3 14288.6 14594.8 14633.1 10845.5 11063.4 11113.3 11306.2 11951.6 11178.5 11768.2 12141.8 12352.6 12390.0 08:27:15 INFO - PROCESS | 3418 | -------- Summary: end -------- 08:27:15 INFO - PROCESS | 3418 | 08:27:16 INFO - TEST-INFO | 3418: exit 0 08:27:16 INFO - TEST-OK | dromaeo_css | took 1114839ms 08:27:16 INFO - TEST-START | kraken 08:27:16 INFO - operating with platform_type : linux_ 08:27:16 INFO - Initialising browser for kraken test... 08:27:16 INFO - TEST-INFO | started process 3605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqEX49/profile http://localhost:43268/getInfo.html) 08:27:20 INFO - PROCESS | 3605 | __metrics Screen width/height:1600/1200 08:27:20 INFO - PROCESS | 3605 | colorDepth:24 08:27:20 INFO - PROCESS | 3605 | Browser inner width/height: 1024/697 08:27:20 INFO - PROCESS | 3605 | __metrics 08:27:21 INFO - PROCESS | 3605 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:22 INFO - TEST-INFO | 3605: exit 0 08:27:22 INFO - Browser initialized. 08:27:22 INFO - Running cycle 1/1 for kraken test... 08:27:22 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqEX49/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:34 INFO - PROCESS | 3690 | RSS: Main: 173977600 08:27:34 INFO - PROCESS | 3690 | 08:27:36 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43268/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:37 INFO - PROCESS | 3690 | RSS: Main: 232325120 08:27:37 INFO - PROCESS | 3690 | 08:27:40 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43268/tests/kraken/driver.html?testName=audio-dft) 08:27:40 INFO - PROCESS | 3690 | RSS: Main: 221970432 08:27:40 INFO - PROCESS | 3690 | 08:27:44 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43268/tests/kraken/driver.html?testName=audio-fft) 08:27:44 INFO - PROCESS | 3690 | RSS: Main: 287010816 08:27:44 INFO - PROCESS | 3690 | 08:27:46 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43268/tests/kraken/driver.html?testName=audio-oscillator) 08:27:47 INFO - PROCESS | 3690 | RSS: Main: 198197248 08:27:47 INFO - PROCESS | 3690 | 08:27:49 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:50 INFO - PROCESS | 3690 | RSS: Main: 201101312 08:27:50 INFO - PROCESS | 3690 | 08:27:53 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43268/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:53 INFO - PROCESS | 3690 | RSS: Main: 238735360 08:27:53 INFO - PROCESS | 3690 | 08:27:57 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43268/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:57 INFO - PROCESS | 3690 | RSS: Main: 238952448 08:27:57 INFO - PROCESS | 3690 | 08:28:00 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43268/tests/kraken/driver.html?testName=json-parse-financial) 08:28:01 INFO - PROCESS | 3690 | RSS: Main: 238772224 08:28:01 INFO - PROCESS | 3690 | 08:28:02 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:03 INFO - PROCESS | 3690 | RSS: Main: 226074624 08:28:03 INFO - PROCESS | 3690 | 08:28:05 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:05 INFO - PROCESS | 3690 | RSS: Main: 230694912 08:28:05 INFO - PROCESS | 3690 | 08:28:07 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:08 INFO - PROCESS | 3690 | RSS: Main: 238125056 08:28:08 INFO - PROCESS | 3690 | 08:28:10 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:11 INFO - PROCESS | 3690 | RSS: Main: 239673344 08:28:11 INFO - PROCESS | 3690 | 08:28:14 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:14 INFO - PROCESS | 3690 | RSS: Main: 239169536 08:28:14 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:43268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43268/tests/kraken/driver.html?testName=ai-astar) 08:28:16 INFO - PROCESS | 3690 | RSS: Main: 283078656 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | __start_tp_report 08:28:16 INFO - PROCESS | 3690 | _x_x_mozilla_page_load 08:28:16 INFO - PROCESS | 3690 | _x_x_mozilla_page_load_details 08:28:16 INFO - PROCESS | 3690 | |i|pagename|runs| 08:28:16 INFO - PROCESS | 3690 | |0;ai-astar;111;106;112;113;112;112;111;110;110;109 08:28:16 INFO - PROCESS | 3690 | |1;audio-beat-detection;163;126;141;185;132;149;152;129;187;123 08:28:16 INFO - PROCESS | 3690 | |2;audio-dft;161;160;161;159;159;161;162;161;161;163 08:28:16 INFO - PROCESS | 3690 | |3;audio-fft;75;75;75;137;75;75;74;75;112;75 08:28:16 INFO - PROCESS | 3690 | |4;audio-oscillator;87;86;118;85;86;85;116;86;86;128 08:28:16 INFO - PROCESS | 3690 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;117;117;118 08:28:16 INFO - PROCESS | 3690 | |6;imaging-darkroom;145;146;145;145;145;146;146;146;145;145 08:28:16 INFO - PROCESS | 3690 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;97;96 08:28:16 INFO - PROCESS | 3690 | |8;json-parse-financial;52;55;54;52;54;52;53;53;51;53 08:28:16 INFO - PROCESS | 3690 | |9;json-stringify-tinderbox;62;62;62;63;63;62;63;62;62;63 08:28:16 INFO - PROCESS | 3690 | |10;stanford-crypto-aes;81;80;81;84;79;81;84;83;107;86 08:28:16 INFO - PROCESS | 3690 | |11;stanford-crypto-ccm;131;126;126;123;121;126;118;124;138;127 08:28:16 INFO - PROCESS | 3690 | |12;stanford-crypto-pbkdf2;163;167;160;167;163;165;163;161;161;161 08:28:16 INFO - PROCESS | 3690 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;65;62;62;63;62 08:28:16 INFO - PROCESS | 3690 | __end_tp_report 08:28:16 INFO - PROCESS | 3690 | __start_cc_report 08:28:16 INFO - PROCESS | 3690 | _x_x_mozilla_cycle_collect,1617 08:28:16 INFO - PROCESS | 3690 | __end_cc_report 08:28:16 INFO - PROCESS | 3690 | __startTimestamp1466522896870__endTimestamp 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | ------- Summary: start ------- 08:28:16 INFO - PROCESS | 3690 | Number of tests: 14 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.01 (1.8%) stddev-sans-first:2.13 08:28:16 INFO - PROCESS | 3690 | Values: 111.0 106.0 112.0 113.0 112.0 112.0 111.0 110.0 110.0 109.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:150.50 stddev:23.34 (15.5%) stddev-sans-first:24.17 08:28:16 INFO - PROCESS | 3690 | Values: 163.0 126.0 141.0 185.0 132.0 149.0 152.0 129.0 187.0 123.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 08:28:16 INFO - PROCESS | 3690 | Values: 161.0 160.0 161.0 159.0 159.0 161.0 162.0 161.0 161.0 163.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.00 stddev:21.74 (29.0%) stddev-sans-first:22.77 08:28:16 INFO - PROCESS | 3690 | Values: 75.0 75.0 75.0 137.0 75.0 75.0 74.0 75.0 112.0 75.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.00 stddev:17.09 (19.9%) stddev-sans-first:17.80 08:28:16 INFO - PROCESS | 3690 | Values: 87.0 86.0 118.0 85.0 86.0 85.0 116.0 86.0 86.0 128.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:28:16 INFO - PROCESS | 3690 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:28:16 INFO - PROCESS | 3690 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 08:28:16 INFO - PROCESS | 3690 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.22 08:28:16 INFO - PROCESS | 3690 | Values: 52.0 55.0 54.0 52.0 54.0 52.0 53.0 53.0 51.0 53.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 08:28:16 INFO - PROCESS | 3690 | Values: 62.0 62.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:8.15 (9.9%) stddev-sans-first:8.54 08:28:16 INFO - PROCESS | 3690 | Values: 81.0 80.0 81.0 84.0 79.0 81.0 84.0 83.0 107.0 86.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:5.50 (4.4%) stddev-sans-first:5.53 08:28:16 INFO - PROCESS | 3690 | Values: 131.0 126.0 126.0 123.0 121.0 126.0 118.0 124.0 138.0 127.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.67 08:28:16 INFO - PROCESS | 3690 | Values: 163.0 167.0 160.0 167.0 163.0 165.0 163.0 161.0 161.0 161.0 08:28:16 INFO - PROCESS | 3690 | 08:28:16 INFO - PROCESS | 3690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 08:28:16 INFO - PROCESS | 3690 | Values: 64.0 63.0 64.0 64.0 63.0 65.0 62.0 62.0 63.0 62.0 08:28:16 INFO - PROCESS | 3690 | -------- Summary: end -------- 08:28:16 INFO - PROCESS | 3690 | 08:28:17 INFO - TEST-INFO | 3690: exit 0 08:28:17 INFO - TEST-OK | kraken | took 61755ms 08:28:17 INFO - SUITE-END | took 1176s 08:28:18 INFO - Completed test suite (00:19:36) 08:28:18 INFO - javascript benchmark 08:28:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.101105173972, 3052.572639830424, 3061.78567500275, 3084.8611812468434, 3103.7516998640112, 5030.949690503094, 5121.052605268019, 5127.820526281581, 5193.428722840485, 5240.633155679099, 5160.380754309488, 5162.716050617215, 5173.974130129353, 5215.191645294976, 5248.448912864152, 4653.418322709661, 4702.929456058162, 4746.620270378378, 4791.952080479203, 4938.358013458245, 4820.445648750386, 4846.151923413388, 4864.075825593126, 4900.558949694527, 4921.680090794087, 4622.722636641795, 4640.60554852838, 4647.32613771003, 4700.2949557566635, 4705.12955103307, 4714.175019371596, 4728.1252968201, 4729.077829823186, 4797.856064318076, 4835.806567737286, 4765.237561990065, 4780.450248221464, 4792.209285467929, 4799.2321228603605, 4843.443004054544, 4967.82612608557, 5039.748012599392, 5150.201718733565, 5217.58259339252, 5219.164933610642, 5565.193047008162, 5594.552435805126, 5621.156826476021, 5654.264945557093, 5657.8585535361535, 5647.689377084259, 5658.0381335173115, 5678.545716342683, 5705.2012718219485, 5706.172604972297, 5045.722485263309, 5176.456472070454, 5240.68555886648, 5243.632945693803, 5313.043652142652, 5775.48020678141, 5785.768569257182, 5786.942130578725, 5788.681622510718, 5790.044642633919, 5267.9736601316745, 5566.0, 5575.303087114111, 5585.273914391184, 5587.888242235133, 5520.972395137998, 5547.611667183339, 5571.693556854412, 5574.470425309589, 5633.957717822216, 5544.085225937675, 5555.111182210827, 5555.416681248492, 5555.611107222456, 5567.498925096761, 5372.973135134299, 5527.751251193626, 5554.472325129106, 5565.30433695788, 5644.096944488944, 4280.079782846703, 4287.485501739811, 4287.6355509782015, 4325.545817689161, 4334.306510958231, 3871.709621778378, 3873.9418908716393, 3888.727789054739, 3899.317619416591, 3922.490076290064, 5210.739463026834, 5334.466553344634, 5337.893242135136, 5355.0, 5363.624546281801, 5637.774489020475, 5684.147377893267, 5697.715114244271, 5701.942980570141, 5757.453041961007, 5433.130699088127, 5444.373897001896, 5445.128779395278, 5447.782088716486, 5451.2640793493165, 4774.785134668949, 4882.194437917704, 4901.779419926112, 4969.27945447908, 5023.447420783711, 5944.464998150187, 5947.988841896974, 5956.970215148983, 5961.672108034013, 5998.3701711320555, 5663.235463212413, 5675.517581005661, 5677.602567820213, 5681.17622944679, 5682.261306030189, 5656.943430565641, 5779.0464573344925, 5815.273090863642, 5834.03738383179, 5950.821475355746, 5483.5064844162625, 5498.972505137449, 5500.339959204921, 5502.9174562380795, 5507.752151153128, 5540.335159780852, 5586.329640443173, 5587.776488940397, 5588.804391846266, 5615.241942337732, 5240.109181439088, 5340.652857564246, 5360.410354860885, 5389.568834493152, 5433.945660543344, 5423.3491980962535, 5424.1321388577635, 5427.701476418835, 5428.050091234098, 5428.972855135699, 5212.061828870688, 5318.627696061239, 5325.893482130413, 5343.679379237258, 5390.676559406448, 5295.576353891603, 5380.408155102858, 5404.486573775485, 5418.160185171305, 5433.538149257357, 5379.435159308373, 5399.865003374947, 5412.9174165167915, 5413.296271484682, 5414.485623865727], "value": 5167.975857268225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.731920635714, 600.5285850607277, 610.8442347201463, 616.4359610955976, 632.8924082905907, 30300.696993030062, 30689.386212275742, 42340.36489452657, 42831.14337713244, 42922.570774292246, 40247.79876100623, 44828.0, 44963.77518112413, 44998.0, 45143.322850157274, 8817.86773198401, 9000.684976025841, 9006.864897026517, 9007.234385077243, 9008.819823603524, 8815.77960550985, 8920.776980575505, 8921.598528066253, 8924.107589241088, 8924.241439477652, 8938.776530586721, 8951.283897288235, 8987.281017518582, 8988.550572471382, 8995.235404990584, 8907.955460222689, 8935.776605584848, 8953.462792232487, 8955.19403253707, 8962.283017358628, 8787.340949428755, 8845.159709827556, 8863.867041994376, 8867.379283450162, 8874.201321880997, 42111.57888421107, 42162.78918605418, 42410.36384454236, 42435.57564424347, 42477.78761106206, 3808.6953043756434, 3826.0, 4111.198316328318, 4287.164003019381, 4369.563043695637, 32841.50737738936, 32944.505832412295, 33397.499037514455, 33470.564836913334, 33838.66161338404, 4320.82716691332, 4327.697061205717, 4357.760323182224, 4386.407834942273, 4457.04173602677, 363936.0, 364987.9999999973, 365621.0, 366082.0, 366781.0, 55873.72063139658, 56157.0, 56310.0, 56351.0, 56603.71698141565, 59027.40972590305, 59120.0, 59143.268538516815, 59223.446593203684, 59409.40590594039, 13420.731585368238, 14877.776833347509, 15329.923350383177, 15388.30752616135, 16080.517584472485, 11987.520499179935, 12050.819237711266, 12076.577319793765, 12095.0, 12096.0, 14498.710025799424, 15873.603159921095, 15937.282822273026, 16028.919855400649, 16047.117408542643, 6531.412172904462, 6838.316168383122, 6880.759173429006, 6892.517523773287, 6964.93035069653, 930.7161315798746, 1053.7471006958428, 1057.2282233969092, 1107.6289443036512, 1111.1000089927024, 32160.19599510031, 32161.356772864412, 32589.87351873266, 32606.0, 32865.67134328626, 1085.2511766880828, 1110.6945589962825, 1129.2264798612975, 1181.6691326428613, 1214.271437137728, 16836.83163168377, 17219.311227551007, 17272.22274997603, 17364.131793410277, 17369.392071277445, 492861.0, 494241.0, 498547.0, 498847.0, 498973.5051324793, 58594.41405585975, 58854.7057264711, 58861.117083243786, 58915.0, 58944.11583826246, 1325.158524337053, 1363.6727185475613, 1375.6148278482042, 1379.5309594737637, 1380.8481067082612, 30883.84558077195, 31452.370952580364, 31987.360252794348, 32210.355792883543, 32700.0, 51294.0, 51585.74207129091, 51738.0, 51754.223686645484, 51773.741131294104, 417048.0, 422710.0, 426244.0, 426452.0, 431728.0, 34676.13309667177, 39654.0, 40573.0, 40952.0, 41563.96090097772, 48517.75741121272, 48889.0, 49167.0, 50150.74924625499, 50290.74854625703, 40747.0, 41174.0, 41262.79368603138, 42756.78621606872, 42959.78520107379, 40455.393169101895, 40582.93614154239, 40951.38572921468, 41511.37732933948, 41741.37387939244, 40506.39240411337, 41222.79388603038, 41244.79377603093, 41503.7924810374, 41766.1646767069, 35105.64894351024, 37054.44418333673, 37583.0, 37649.0, 37933.62066379301, 27160.456790863678, 27824.16527504178, 27838.304042398293, 27917.860410697816, 28174.85912570424], "value": 20159.38252936665, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.4184402474274, 386.7018093886453, 386.8820009896982, 397.31264911702755, 416.29853696521366, 14403.423863045466, 16041.839581604181, 18036.0, 19644.705329420052, 19649.31227407041, 18366.908165459186, 19318.61362772747, 19580.314688985887, 19582.70625940612, 19655.410337689857, 5625.240592520019, 5646.717664116798, 5685.260916080903, 5738.081906894898, 5778.248827652399, 4102.958970410287, 5675.063614503602, 5701.971490142543, 5743.425657434265, 6172.9074063889075, 6443.033544968245, 6487.902681459782, 6518.152640156797, 6579.703913323888, 6579.93420065798, 6357.841053973688, 6433.774817881375, 6477.870442591146, 6526.053722210277, 6541.443977261938, 5691.601587888849, 5755.338136114358, 5760.711964401805, 5770.7691692332255, 5788.42115788422, 21616.675749863763, 21982.89008554963, 22608.54782904349, 22615.208467703716, 22766.65850012251, 2529.6332031855463, 2602.869856507186, 2802.5604128417563, 3067.1871953932227, 3083.321669232765, 13189.0, 13909.165450072927, 14162.433502659984, 14531.128132312095, 14654.926725366411, 1855.2857149997212, 1879.1262063140568, 1879.5348374912921, 1929.9807001929942, 1987.49318923675, 79462.20537794664, 80211.19788802095, 81243.0, 82489.58755206186, 84239.57880210559, 10853.643294588177, 10962.725931851608, 10996.725081873017, 11024.0, 11094.55621775136, 13240.602781916557, 13659.453621855015, 15301.540953771404, 15366.154861482502, 15371.38514459409, 7517.511361761577, 7744.380449564022, 7749.302562769378, 7778.327659553223, 7939.523628582304, 7214.0, 7294.343509084208, 7331.853362932711, 7449.925500744923, 7522.0, 4663.393758811333, 4682.672212945061, 4718.900089460226, 4751.382320298409, 4822.469528351879, 1954.5699946011855, 1990.7212990181386, 1996.780354161041, 1998.2506560039985, 2010.8793472391703, 883.571467838098, 983.3804703037041, 1036.5801850250662, 1041.1046500009986, 1093.0981939899614, 18199.363022294157, 18520.0, 18817.15322810477, 18880.43358699241, 19165.32921347746, 927.1794461901266, 949.6296444386695, 970.8252514547308, 976.2824324121765, 979.0, 10332.0, 10643.84034239487, 10715.892841071489, 10758.0855627271, 10778.838317425088, 454158.0, 461915.0, 462799.0, 469612.0, 473405.0, 92066.53966730123, 95317.0, 95559.52220238854, 96030.0, 97157.0, 948.7343543807744, 962.1100482054072, 963.7879666473365, 972.5526257921294, 981.1218959031627, 16700.0, 16881.155942203088, 16899.91550042242, 16900.0, 17110.315587376364, 30356.696433035388, 38684.226315474094, 40130.598694013854, 40274.1945161101, 42325.57674423217, 51131.0, 52792.0, 53899.46100538944, 54072.72963635314, 54084.72957635186, 8220.465669731448, 8245.628946697292, 8434.451760635538, 8479.024912135183, 8573.91426085756, 9274.814503709753, 11101.667799864068, 12695.238285702888, 13099.083064185797, 13681.657958550717, 8053.557054362066, 11497.08023358146, 11595.536178552764, 11973.16187866841, 11994.820077699016, 11799.410029498318, 11904.821427678766, 11929.46317415701, 12044.036477081987, 12224.69438264015, 11745.941270293593, 11776.528938842694, 12029.699257518632, 12149.75700486003, 12173.20874143178, 7428.0, 7549.131849837119, 8506.914930850613, 8581.613827377907, 8742.0, 6040.909386359121, 8059.758207253792, 11689.298642081163, 11695.532178712756, 11838.408079596158], "value": 9167.657963962765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.0875973678828, 1458.5843034735103, 1480.3190532355115, 1604.8796340274475, 1739.5042412912323, 7692.961535192323, 8003.119656837744, 8030.478018928773, 8207.05618853832, 8212.425130240885, 7936.880946785788, 8099.757007289776, 8110.067342255642, 8113.391495637836, 8113.756587302376, 1984.1864835417482, 2204.834637402193, 2278.7949084582424, 2292.713410823647, 2304.412374844421, 2284.908603655852, 2290.1640901071073, 2293.655951607264, 2296.552172326397, 2299.655051742235, 2275.215050807477, 2281.281396360141, 2314.3866875278063, 2318.014843691433, 2320.512692334612, 1898.069945726591, 2151.7740637233023, 2228.0864845413466, 2234.240358278177, 2237.7090978172896, 2220.222921977311, 2229.0749339024287, 2254.2673631069806, 2261.8416710830247, 2262.479629685165, 8195.46729462589, 8304.128066552985, 8313.916860831374, 8318.8336233275, 8322.45904016237, 4852.927206091911, 4976.950230497685, 4984.102861484931, 4988.0023995200745, 4988.376452943382, 2991.3718119194996, 3172.6034245719284, 3180.2685382361956, 3205.214722393005, 3219.7585181111513, 1137.2266858536193, 1138.9658310250707, 1152.2913408253864, 1157.589055885157, 1175.400545721688, 10916.508757106028, 10931.672049838518, 10971.615993440191, 10982.725431864188, 10988.890111098866, 4170.854020109282, 4261.190373828963, 4336.848210312687, 4361.171377438277, 4373.606375426227, 9315.580798864068, 9353.39202951806, 9355.158035776813, 9358.53207339644, 9360.344775865624, 4898.853034408973, 4899.5590396863745, 4900.877478063006, 4905.166121759309, 4907.1903135982875, 4003.199360127986, 4396.230659634615, 4529.728216307032, 4540.2054640438455, 4594.287885377772, 3741.345264578688, 3792.469054332396, 3832.865849695247, 3852.768833869977, 3892.8832135035996, 1219.6950762309423, 1260.8991280697521, 1269.650846017334, 1277.6550331410467, 1280.9103362764704, 925.8472352061834, 979.9314048016571, 980.54404701814, 1005.6329439754584, 1022.1414012229762, 5877.294724633071, 5973.163757074013, 6007.249093863267, 6074.969625151934, 6081.787137450168, 446.2035267048303, 456.6734784629006, 467.0728603721678, 990.5195979949718, 1075.231209685079, 4161.91676166475, 4211.7262377945335, 4235.470566179228, 4278.529361770203, 4307.784610769449, 9797.657082002095, 10056.899431005742, 10183.33808302458, 10187.439690816927, 10191.082802547659, 10043.748906277255, 10048.49757512136, 10069.54687039085, 10073.848892266622, 10081.344712593658, 7217.2421895701245, 7584.62076896153, 7704.807379815549, 7805.843883122306, 7825.530468171814, 5919.230500034968, 5931.466168044896, 5959.314678811992, 6123.908141377972, 6141.324454309933, 8702.434341767765, 9107.772305692411, 9125.269978401579, 9295.76760580991, 9388.248940084914, 8870.42342247752, 9305.20905722994, 9320.0, 9341.859872102059, 9348.252139828934, 6963.373296403348, 7571.886421703569, 7629.580373079534, 7867.960660196892, 8023.759287221393, 8096.271335579826, 8103.554304513308, 8126.756197313854, 8164.5917704115745, 8171.509709417454, 6812.318768123148, 7256.7097316106765, 7391.741289055072, 7430.108386993596, 7476.476646634684, 7158.0, 7324.230955749783, 7326.3040011198855, 7336.889946650697, 7382.2617738225745, 6754.696038678369, 6824.249332573512, 6831.726730930707, 6832.043513907957, 6834.179898412222, 5026.824061157842, 5082.136036873666, 5084.745762711776, 5144.331236939174, 5187.24784906179, 5112.028714544224, 5141.434442211279, 5175.327207463006, 5202.375714914235, 5235.136202526541], "value": 4404.9369559996485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.42246563038015, 301.37765514213146, 308.9289463423413, 309.22847495498735, 310.91916101813536, 5107.38711354638, 5246.134387826009, 5250.501202385777, 5303.734813259341, 5307.097793375126, 5177.482251774821, 5244.370675518933, 5250.159974404087, 5252.293004773454, 5279.5512381447625, 4062.3500239961613, 4065.9022064042692, 4093.0995181060193, 4111.897202569945, 4150.688698347621, 3862.86479973201, 3883.8446462141483, 4111.979440102796, 4118.238125946695, 4146.0, 4028.952472357179, 4047.170330082326, 4076.9184616307657, 4080.5919408059253, 4083.5099788025477, 4034.293998550242, 4049.068714195737, 4071.1247081877536, 4075.2868248056766, 4083.3670781028986, 3509.7543171977973, 3600.0999750062483, 3617.4573813928123, 3623.40213864712, 3627.8209581885994, 5028.723420211887, 5040.899182016376, 5050.141475949061, 5068.5691716204165, 5142.331496905415, 4598.195315819752, 4621.74580398078, 4625.726671594385, 4660.324252983332, 4675.602573781232, 5248.973755131238, 5405.675659460445, 5442.591805614595, 5451.127819548853, 5478.726063696799, 3848.8845334640005, 3886.650201481852, 3888.786116763577, 3895.1692704428874, 3924.0189952511873, 5566.248556444869, 5581.190727344512, 5630.746616402272, 5637.58925849859, 5652.943470565324, 3965.9490235087724, 3966.3852102924093, 3973.1854969731135, 3993.4009898514873, 4030.435738996543, 3945.8421663133727, 4036.2734707752297, 4042.3734321180264, 4043.130726893673, 4045.0, 4526.140033393644, 4530.97734511332, 4532.660050496226, 4590.403247577793, 4614.661748093083, 5422.8373148805595, 5432.837014889559, 5457.508824205841, 5466.316710411199, 5470.480304371078, 1293.767121918045, 1338.7683331335195, 1407.366684991758, 1419.233613848531, 1419.5102689572082, 874.6107981947972, 895.4806212396794, 904.3172404834309, 906.2976193450129, 910.7905181808221, 4786.803299175206, 4800.855974320776, 4825.95174048262, 4883.243097319921, 4916.385451818523, 4893.6329775266995, 4945.55490005894, 4952.925706114411, 4979.30289759434, 4984.451710311862, 4529.433820772403, 4774.40319960005, 4790.808367665254, 4793.664443488922, 4808.807647694053, 2646.491499845108, 2655.349439387324, 2673.26485216567, 2677.6920654124638, 2682.973170268311, 5186.299849520342, 5212.582993360522, 5225.503577160163, 5225.790968361299, 5296.390915044819, 4824.469308376076, 4992.803166606682, 5024.397072351341, 5039.496050394931, 5044.672096313728, 5137.768800403991, 5155.407128180233, 5168.095583272912, 5268.973655131853, 5294.23233631129, 4958.264607387529, 5014.724190169576, 5028.245763135559, 5040.908023170343, 5061.468545802638, 4646.0486595629245, 4925.87207123472, 4944.887400334896, 4956.529129732669, 4980.750962451935, 5096.23556466533, 5165.354330708661, 5183.870403239949, 5210.244514545446, 5234.7906083756225, 3656.1956369598647, 3666.4133738601695, 3677.1206377272233, 3746.4754934309763, 3900.687944964453, 5160.612954028388, 5210.5831533477985, 5509.614326997232, 5530.419305972976, 5576.888462230814, 5359.839204823861, 5384.300040994645, 5445.618806683494, 5461.481159289861, 5529.391766905717, 5365.22204280385, 5413.24214609947, 5439.782408703608, 5474.972625137008, 5482.479164479368, 5279.920801187908, 5350.705711185767, 5377.3816011159215, 5382.919256211082, 5429.0, 5473.890522189454, 5481.725913704219, 5493.23094766725, 5494.077073024409, 5533.280673512418, 5349.619419358503, 5355.785768569213, 5360.142377219626, 5369.570434365163, 5407.324084489439], "value": 4017.3437647720107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6189657584904, 712.8253577873422, 730.5470608222903, 732.3335764454348, 749.9212582678819, 14977.850221497796, 15821.288042038108, 15825.84174158258, 16013.599660008505, 16403.179841007946, 14803.851961480383, 14830.777538336934, 14944.701105977874, 14976.0, 14993.47522836701, 659.967001649918, 776.4448419380142, 806.6732973145886, 823.0493779684474, 831.5010993403939, 822.786075620337, 823.1932705948144, 825.8183199696088, 826.0665448043702, 826.89663792026, 862.1464749897588, 862.5644049754865, 863.2791618998144, 863.9308855291594, 863.9913600864005, 687.5977553131399, 798.3732769775727, 862.0345213361076, 865.4763867859917, 866.1987661413231, 632.4213344789558, 633.5470138850744, 633.727497176214, 633.7718421368304, 633.9587926784744, 14479.42082316706, 14676.926615366961, 14699.19154446505, 14734.70530589393, 14735.55793326202, 13960.441582336694, 14017.789733154012, 14083.225422601752, 14105.858941410557, 14261.358238879171, 12705.237685738884, 12712.555060572928, 12858.164219325714, 13026.934865325708, 13046.478140874353, 4252.87241382759, 4272.1028583997395, 4317.11499142675, 4369.715968462072, 4399.274119770234, 69543.0, 69654.0, 69979.30020699778, 70046.99999999949, 70251.2974870255, 11388.772224555463, 11389.202755807013, 11446.771064578828, 11459.48432320531, 11503.53985840557, 18883.150258238136, 18902.432927011938, 18906.905465472584, 18918.43244702661, 18963.715544266848, 7853.764387068397, 7864.174261702439, 8276.958615206886, 8399.664013439517, 8500.574971251413, 4600.539946005372, 4629.65277604181, 4671.6262698984, 4682.297655351725, 4796.112719146969, 3362.9327413451592, 3478.9478157827652, 3479.59984601774, 3480.2691434798976, 3491.94762078569, 621.6580880515698, 627.3788948940517, 627.4290395739855, 642.4442856928723, 646.4731244036095, 602.2802750712856, 685.1196212866442, 687.4878215729213, 714.9964250178716, 718.4934621092118, 9552.90447095534, 9560.330776845554, 9569.61721531131, 9634.518274086407, 9673.516324183762, 592.5792687192055, 606.9059295809157, 633.9856230032004, 665.4377051391566, 696.7073828991836, 4482.372467854503, 4636.258198688193, 4678.812847486062, 4719.2921061841, 4816.4220293564995, 107211.46394267978, 108814.0, 109053.0, 113224.0, 113734.43132784283, 96321.0, 96494.9999999986, 96810.51594741982, 97237.0, 98002.0, 83780.58109709412, 84395.57802210949, 84834.0, 85312.0, 85862.57068714492, 8682.609282582425, 8691.608877600649, 8756.649734010569, 8810.823783524422, 8872.689455869013, 48744.0251194967, 50621.49378506168, 51069.74465127651, 51130.277526605765, 52181.21728174004, 45208.32187517124, 45795.542044579124, 46116.53883461122, 63802.68098659477, 66932.33067669456, 12858.228506289652, 13697.452101915811, 13712.108712933627, 13747.725045499234, 13932.651683707989, 8130.715424960098, 14448.783268250774, 15003.2498375083, 15005.32476038559, 15052.698946021237, 13995.072717157876, 14306.427742890168, 14691.41234350614, 14801.851981480047, 14935.327910243848, 13718.93140534291, 14053.508127215498, 14130.0, 14440.494582689555, 14472.638184045483, 13932.373043213283, 14279.286035698382, 14288.57134285973, 14594.781078283622, 14633.122012679274, 10845.511951962022, 11063.446827658423, 11113.277636953571, 11306.208565400342, 11951.581694640647, 11178.496967636313, 11768.228776763262, 12141.816415735751, 12352.62942111738, 12390.0], "value": 7426.592053158575, "unit": "score"}], "name": "dromaeo_css", "value": 7076.128406100164, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 113.0, 112.0, 112.0, 111.0, 110.0, 110.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 141.0, 185.0, 132.0, 149.0, 152.0, 129.0, 187.0, 123.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 159.0, 161.0, 162.0, 161.0, 161.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 137.0, 75.0, 75.0, 74.0, 75.0, 112.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 118.0, 85.0, 86.0, 85.0, 116.0, 86.0, 86.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 52.0, 54.0, 52.0, 53.0, 53.0, 51.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 84.0, 79.0, 81.0, 84.0, 83.0, 107.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 126.0, 126.0, 123.0, 121.0, 126.0, 118.0, 124.0, 138.0, 127.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 160.0, 167.0, 163.0, 165.0, 163.0, 161.0, 161.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 65.0, 62.0, 62.0, 63.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1511.8999999999999, "alertThreshold": 2.0}]} 08:28:18 INFO - Return code: 0 08:28:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:28:18 INFO - # TBPL SUCCESS # 08:28:18 INFO - Running post-action listener: _resource_record_post_action 08:28:18 INFO - ##### 08:28:18 INFO - ##### Finished run-tests step (success) 08:28:18 INFO - ##### 08:28:18 INFO - Running post-run listener: _resource_record_post_run 08:28:18 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 437473280; Read time: 1848; Write time: 457348 08:28:18 INFO - TinderboxPrint: CPU usage
13.3% 08:28:18 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 1,848 08:28:18 INFO - TinderboxPrint: I/O write bytes / time
437,473,280 / 457,348 08:28:18 INFO - TinderboxPrint: CPU idle
8,267.4 (86.7%) 08:28:18 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 08:28:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:28:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100175872; Read time: 0; Write time: 100996 08:28:18 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6082560; Write bytes: 337297408; Read time: 1780; Write time: 356352 08:28:18 INFO - Running post-run listener: _upload_blobber_files 08:28:18 INFO - Blob upload gear active. 08:28:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:18 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 08:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:19 INFO - (blobuploader) - INFO - Done attempting. 08:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:23 INFO - (blobuploader) - INFO - Done attempting. 08:28:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:28:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:23 INFO - (blobuploader) - INFO - Done attempting. 08:28:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:23 INFO - Return code: 0 08:28:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d994525ae71b37474e4b18f7d9cc2daf1ba6a9891faa5402db2760eaefe30c01ac8e60dc2d48b8abfbceb0fd89f036089e146377605befec8ab4eed16ae05fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21b93c3c12290b060f3bfca34c1833e2911a8a1351b9b94a6e24b56b09c596ab9b8dd175188541634c7d772ea2100a54ad4f2ef6259d9dc37430a777219f20ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d0d3c06fdc0a816037f6575818b552665f1b60feeb97533970b9e2de08752023682de39969bdefdaa4a6e765c0673bb95f8cb83722537fd2831bdfec2a8961f"} 08:28:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:23 INFO - Contents: 08:28:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d994525ae71b37474e4b18f7d9cc2daf1ba6a9891faa5402db2760eaefe30c01ac8e60dc2d48b8abfbceb0fd89f036089e146377605befec8ab4eed16ae05fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21b93c3c12290b060f3bfca34c1833e2911a8a1351b9b94a6e24b56b09c596ab9b8dd175188541634c7d772ea2100a54ad4f2ef6259d9dc37430a777219f20ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d0d3c06fdc0a816037f6575818b552665f1b60feeb97533970b9e2de08752023682de39969bdefdaa4a6e765c0673bb95f8cb83722537fd2831bdfec2a8961f"} 08:28:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:23 INFO - Copying logs to upload dir... 08:28:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.394488 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-21 08:28:23.795186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:28:23.798931) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d994525ae71b37474e4b18f7d9cc2daf1ba6a9891faa5402db2760eaefe30c01ac8e60dc2d48b8abfbceb0fd89f036089e146377605befec8ab4eed16ae05fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21b93c3c12290b060f3bfca34c1833e2911a8a1351b9b94a6e24b56b09c596ab9b8dd175188541634c7d772ea2100a54ad4f2ef6259d9dc37430a777219f20ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d0d3c06fdc0a816037f6575818b552665f1b60feeb97533970b9e2de08752023682de39969bdefdaa4a6e765c0673bb95f8cb83722537fd2831bdfec2a8961f"} build_url:https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d994525ae71b37474e4b18f7d9cc2daf1ba6a9891faa5402db2760eaefe30c01ac8e60dc2d48b8abfbceb0fd89f036089e146377605befec8ab4eed16ae05fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21b93c3c12290b060f3bfca34c1833e2911a8a1351b9b94a6e24b56b09c596ab9b8dd175188541634c7d772ea2100a54ad4f2ef6259d9dc37430a777219f20ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d0d3c06fdc0a816037f6575818b552665f1b60feeb97533970b9e2de08752023682de39969bdefdaa4a6e765c0673bb95f8cb83722537fd2831bdfec2a8961f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:28:23.824041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:28:23.824363) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466520571.945716-1640598755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:28:23.907946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:28:23.908333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:28:23.908661) ========= ========= Total master_lag: 0.14 =========