builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1465552572.95 results: success (0) buildid: 20160610021229 builduid: 59daad57660840af97e0516db159a1bc revision: c69b3fef9219c2da558d92246796df38be793593 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:12.948497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:12.948973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:12.949392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.012895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.013190) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 02:56:13-- 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% 37.6M=0s 2016-06-10 02:56:13 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.160427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.160758) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014975 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.210193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.210557) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c69b3fef9219c2da558d92246796df38be793593 --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 c69b3fef9219c2da558d92246796df38be793593 --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=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 02:56:13,643 truncating revision to first 12 chars 2016-06-10 02:56:13,643 Setting DEBUG logging. 2016-06-10 02:56:13,643 attempt 1/10 2016-06-10 02:56:13,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c69b3fef9219?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 02:56:13,987 unpacking tar archive at: fx-team-c69b3fef9219/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683905 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.907473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.907773) ========= script_repo_revision: c69b3fef9219c2da558d92246796df38be793593 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.908149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.908427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:56:13.916058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-10 02:56:13.916364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:14 INFO - MultiFileLogger online at 20160610 02:56:14 in /builds/slave/test 02:56:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:56:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:14 INFO - {'append_to_log': False, 02:56:14 INFO - 'base_work_dir': '/builds/slave/test', 02:56:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:56:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:14 INFO - 'branch': 'Fx-Team-Non-PGO', 02:56:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:14 INFO - 'config_files': ('talos/linux_config.py',), 02:56:14 INFO - 'default_actions': ('clobber', 02:56:14 INFO - 'read-buildbot-config', 02:56:14 INFO - 'download-and-extract', 02:56:14 INFO - 'populate-webroot', 02:56:14 INFO - 'create-virtualenv', 02:56:14 INFO - 'install', 02:56:14 INFO - 'run-tests'), 02:56:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:14 INFO - 'download_minidump_stackwalk': True, 02:56:14 INFO - 'download_symbols': 'ondemand', 02:56:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:14 INFO - 'installer_path': 'installer.exe', 02:56:14 INFO - 'log_level': 'info', 02:56:14 INFO - 'log_name': 'talos', 02:56:14 INFO - 'log_to_console': True, 02:56:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:14 INFO - 'opt_config_files': (), 02:56:14 INFO - 'pip_index': False, 02:56:14 INFO - 'sps_profile': False, 02:56:14 INFO - 'sps_profile_interval': 0, 02:56:14 INFO - 'suite': 'dromaeojs-e10s', 02:56:14 INFO - 'system_bits': '32', 02:56:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:14 INFO - 'title': 'talos-linux64-ix-057', 02:56:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:14 INFO - 'use_talos_json': True, 02:56:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:14 INFO - 'work_dir': 'build'} 02:56:14 INFO - ##### 02:56:14 INFO - ##### Running clobber step. 02:56:14 INFO - ##### 02:56:14 INFO - Running pre-action listener: _resource_record_pre_action 02:56:14 INFO - Running main action method: clobber 02:56:14 INFO - rmtree: /builds/slave/test/build 02:56:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:15 INFO - Running post-action listener: _resource_record_post_action 02:56:15 INFO - ##### 02:56:15 INFO - ##### Finished clobber step (success) 02:56:15 INFO - ##### 02:56:15 INFO - ##### 02:56:15 INFO - ##### Running read-buildbot-config step. 02:56:15 INFO - ##### 02:56:15 INFO - Running pre-action listener: _resource_record_pre_action 02:56:15 INFO - Running main action method: read_buildbot_config 02:56:15 INFO - Using buildbot properties: 02:56:15 INFO - { 02:56:15 INFO - "project": "", 02:56:15 INFO - "product": "firefox", 02:56:15 INFO - "script_repo_revision": "production", 02:56:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:56:15 INFO - "repository": "", 02:56:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:56:15 INFO - "buildid": "20160610021229", 02:56:15 INFO - "pgo_build": "False", 02:56:15 INFO - "basedir": "/builds/slave/test", 02:56:15 INFO - "buildnumber": 1400, 02:56:15 INFO - "slavename": "talos-linux64-ix-057", 02:56:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:56:15 INFO - "platform": "ubuntu64_hw", 02:56:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:56:15 INFO - "branch": "fx-team", 02:56:15 INFO - "repo_path": "integration/fx-team", 02:56:15 INFO - "revision": "c69b3fef9219c2da558d92246796df38be793593", 02:56:15 INFO - "stage_platform": "linux64", 02:56:15 INFO - "builduid": "59daad57660840af97e0516db159a1bc", 02:56:15 INFO - "slavebuilddir": "test" 02:56:15 INFO - } 02:56:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:56:15 INFO - Running post-action listener: _resource_record_post_action 02:56:15 INFO - ##### 02:56:15 INFO - ##### Finished read-buildbot-config step (success) 02:56:15 INFO - ##### 02:56:15 INFO - ##### 02:56:15 INFO - ##### Running download-and-extract step. 02:56:15 INFO - ##### 02:56:15 INFO - Running pre-action listener: _resource_record_pre_action 02:56:15 INFO - Running main action method: download_and_extract 02:56:15 INFO - mkdir: /builds/slave/test/build/tests 02:56: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')]} 02:56:15 INFO - https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:19 INFO - Downloaded 1361 bytes. 02:56:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:56:19 INFO - Using the following test package requirements: 02:56:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:56:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:56:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:56:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'jsshell-linux-x86_64.zip'], 02:56:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:56:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:56:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:56:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:56:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:56:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:56:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:56: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')]} 02:56:19 INFO - https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:21 INFO - Downloaded 22879604 bytes. 02:56:21 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'] 02:56:21 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 02:56:22 INFO - Return code: 0 02:56:22 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 02:56:22 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')]} 02:56:22 INFO - https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:23 INFO - Downloaded 22879604 bytes. 02:56:23 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'] 02:56:23 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 02:56:24 INFO - Return code: 0 02:56:24 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')]} 02:56:24 INFO - https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:25 INFO - Downloaded 10833377 bytes. 02:56:25 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'] 02:56:25 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 02:56:26 INFO - Return code: 0 02:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:26 INFO - https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XjDuF68eTNiBkkMbEz2xgA/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 02:56:30 INFO - Downloaded 55380987 bytes. 02:56:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:56:30 INFO - mkdir: /builds/slave/test/properties 02:56:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:56:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:56:30 INFO - Contents: 02:56:30 INFO - build_url:https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:56:31 INFO - Running post-action listener: _resource_record_post_action 02:56:31 INFO - Running post-action listener: set_extra_try_arguments 02:56:31 INFO - ##### 02:56:31 INFO - ##### Finished download-and-extract step (success) 02:56:31 INFO - ##### 02:56:31 INFO - ##### 02:56:31 INFO - ##### Running populate-webroot step. 02:56:31 INFO - ##### 02:56:31 INFO - Running pre-action listener: _resource_record_pre_action 02:56:31 INFO - Running main action method: populate_webroot 02:56:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:56:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:56:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:56:31 INFO - '--tppagecycles', 02:56:31 INFO - '7'], 02:56:31 INFO - 'tests': ['tsvgm']}}, 02:56:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:56:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:56:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:56:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:56:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['damp', 'tps']}, 02:56:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'tests': ['damp', 'tps']}, 02:56:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['dromaeo_dom']}, 02:56:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:56:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'other-e10s': {'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['a11yr', 02:56:31 INFO - 'ts_paint', 02:56:31 INFO - 'tpaint', 02:56:31 INFO - 'sessionrestore', 02:56:31 INFO - 'sessionrestore_no_auto_restore', 02:56:31 INFO - 'tabpaint']}, 02:56:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['tsvgx', 02:56:31 INFO - 'tsvgr_opacity', 02:56:31 INFO - 'tart', 02:56:31 INFO - 'tscrollx', 02:56:31 INFO - 'cart']}, 02:56:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:56:31 INFO - 'tsvgr_opacity', 02:56:31 INFO - 'tart', 02:56:31 INFO - 'tscrollx', 02:56:31 INFO - 'cart']}, 02:56:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'talos_options': ['--disable-e10s'], 02:56:31 INFO - 'tests': ['tp5o']}, 02:56:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'tests': ['tp5o']}, 02:56:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'talos_options': ['--disable-e10s', 02:56:31 INFO - '--xperf_path', 02:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:31 INFO - 'tests': ['tp5n']}, 02:56:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:31 INFO - 'talos_options': ['--xperf_path', 02:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:31 INFO - 'tests': ['tp5n']}}, 02:56:31 INFO - 'talos.zip': {'path': '', 02:56:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:56:31 INFO - Running post-action listener: _resource_record_post_action 02:56:31 INFO - ##### 02:56:31 INFO - ##### Finished populate-webroot step (success) 02:56:31 INFO - ##### 02:56:31 INFO - ##### 02:56:31 INFO - ##### Running create-virtualenv step. 02:56:31 INFO - ##### 02:56:31 INFO - Running pre-action listener: _resource_record_pre_action 02:56:31 INFO - Running main action method: create_virtualenv 02:56:31 INFO - Creating virtualenv /builds/slave/test/build/venv 02:56:31 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 02:56:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:56:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:56:31 INFO - Using real prefix '/usr' 02:56:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:56:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:56:33 INFO - Installing pip.................done. 02:56:33 INFO - Return code: 0 02:56:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:56:33 INFO - Using env: {'DISPLAY': ':0', 02:56:33 INFO - 'HOME': '/home/cltbld', 02:56:33 INFO - 'LANG': 'en_US.UTF-8', 02:56:33 INFO - 'LANGUAGE': 'en_US:en', 02:56:33 INFO - 'LOGNAME': 'cltbld', 02:56:33 INFO - 'MAIL': '/var/mail/cltbld', 02:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:33 INFO - 'MOZ_NO_REMOTE': '1', 02:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:33 INFO - 'NO_EM_RESTART': '1', 02:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:33 INFO - 'PWD': '/builds/slave/test', 02:56:33 INFO - 'SHELL': '/bin/bash', 02:56:33 INFO - 'SHLVL': '1', 02:56:33 INFO - 'TERM': 'linux', 02:56:33 INFO - 'TMOUT': '86400', 02:56:33 INFO - 'USER': 'cltbld', 02:56:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:33 INFO - '_': '/tools/buildbot/bin/python'} 02:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:33 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 02:56:33 INFO - Cleaning up... 02:56:33 INFO - Return code: 0 02:56:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:56:33 INFO - Using env: {'DISPLAY': ':0', 02:56:33 INFO - 'HOME': '/home/cltbld', 02:56:33 INFO - 'LANG': 'en_US.UTF-8', 02:56:33 INFO - 'LANGUAGE': 'en_US:en', 02:56:33 INFO - 'LOGNAME': 'cltbld', 02:56:33 INFO - 'MAIL': '/var/mail/cltbld', 02:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:33 INFO - 'MOZ_NO_REMOTE': '1', 02:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:33 INFO - 'NO_EM_RESTART': '1', 02:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:33 INFO - 'PWD': '/builds/slave/test', 02:56:33 INFO - 'SHELL': '/bin/bash', 02:56:33 INFO - 'SHLVL': '1', 02:56:33 INFO - 'TERM': 'linux', 02:56:33 INFO - 'TMOUT': '86400', 02:56:33 INFO - 'USER': 'cltbld', 02:56:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:33 INFO - '_': '/tools/buildbot/bin/python'} 02:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:34 INFO - Downloading/unpacking psutil>=3.1.1 02:56:34 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 02:56:34 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 02:56:34 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 02:56:34 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 02:56:34 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 02:56:34 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 02:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:36 INFO - Installing collected packages: psutil 02:56:36 INFO - Running setup.py install for psutil 02:56:36 INFO - building 'psutil._psutil_linux' extension 02:56:36 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 02:56:36 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 02:56:36 INFO - building 'psutil._psutil_posix' extension 02:56:36 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 02:56:36 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 02:56:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:36 INFO - Successfully installed psutil 02:56:36 INFO - Cleaning up... 02:56:36 INFO - Return code: 0 02:56:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:36 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:36 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 02:56:36 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 02:56:36 INFO - Using env: {'DISPLAY': ':0', 02:56:36 INFO - 'HOME': '/home/cltbld', 02:56:36 INFO - 'LANG': 'en_US.UTF-8', 02:56:36 INFO - 'LANGUAGE': 'en_US:en', 02:56:36 INFO - 'LOGNAME': 'cltbld', 02:56:36 INFO - 'MAIL': '/var/mail/cltbld', 02:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:36 INFO - 'MOZ_NO_REMOTE': '1', 02:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:36 INFO - 'NO_EM_RESTART': '1', 02:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:36 INFO - 'PWD': '/builds/slave/test', 02:56:36 INFO - 'SHELL': '/bin/bash', 02:56:36 INFO - 'SHLVL': '1', 02:56:36 INFO - 'TERM': 'linux', 02:56:36 INFO - 'TMOUT': '86400', 02:56:36 INFO - 'USER': 'cltbld', 02:56:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:36 INFO - '_': '/tools/buildbot/bin/python'} 02:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56:36 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 02:56:36 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 02:56:36 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 02:56:36 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 02:56:36 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 02:56:36 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 02:56:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:38 INFO - Installing collected packages: mozsystemmonitor 02:56:38 INFO - Running setup.py install for mozsystemmonitor 02:56:38 INFO - Successfully installed mozsystemmonitor 02:56:38 INFO - Cleaning up... 02:56:38 INFO - Return code: 0 02:56:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56:38 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')]} 02:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:38 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')]} 02:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:38 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:38 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 02:56:38 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 02:56:38 INFO - Using env: {'DISPLAY': ':0', 02:56:38 INFO - 'HOME': '/home/cltbld', 02:56:38 INFO - 'LANG': 'en_US.UTF-8', 02:56:38 INFO - 'LANGUAGE': 'en_US:en', 02:56:38 INFO - 'LOGNAME': 'cltbld', 02:56:38 INFO - 'MAIL': '/var/mail/cltbld', 02:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:38 INFO - 'MOZ_NO_REMOTE': '1', 02:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:38 INFO - 'NO_EM_RESTART': '1', 02:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:38 INFO - 'PWD': '/builds/slave/test', 02:56:38 INFO - 'SHELL': '/bin/bash', 02:56:38 INFO - 'SHLVL': '1', 02:56:38 INFO - 'TERM': 'linux', 02:56:38 INFO - 'TMOUT': '86400', 02:56:38 INFO - 'USER': 'cltbld', 02:56:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:38 INFO - '_': '/tools/buildbot/bin/python'} 02:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:39 INFO - Downloading/unpacking jsonschema==2.5.1 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:40 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 02:56:40 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 02:56:40 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 02:56:40 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 02:56:40 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 02:56:40 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 02:56:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:41 INFO - warning: no files found matching '*.txt' 02:56:41 INFO - no previously-included directories found matching 'build' 02:56:41 INFO - no previously-included directories found matching 'dist' 02:56:41 INFO - no previously-included directories found matching '.git*' 02:56:41 INFO - Installing collected packages: jsonschema, functools32 02:56:41 INFO - Running setup.py install for functools32 02:56:41 INFO - warning: no files found matching '*.txt' 02:56:41 INFO - no previously-included directories found matching 'build' 02:56:41 INFO - no previously-included directories found matching 'dist' 02:56:41 INFO - no previously-included directories found matching '.git*' 02:56:41 INFO - Successfully installed jsonschema functools32 02:56:41 INFO - Cleaning up... 02:56:41 INFO - Return code: 0 02:56:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:41 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:41 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 02:56:41 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 02:56:41 INFO - Using env: {'DISPLAY': ':0', 02:56:41 INFO - 'HOME': '/home/cltbld', 02:56:41 INFO - 'LANG': 'en_US.UTF-8', 02:56:41 INFO - 'LANGUAGE': 'en_US:en', 02:56:41 INFO - 'LOGNAME': 'cltbld', 02:56:41 INFO - 'MAIL': '/var/mail/cltbld', 02:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:41 INFO - 'MOZ_NO_REMOTE': '1', 02:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:41 INFO - 'NO_EM_RESTART': '1', 02:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:41 INFO - 'PWD': '/builds/slave/test', 02:56:41 INFO - 'SHELL': '/bin/bash', 02:56:41 INFO - 'SHLVL': '1', 02:56:41 INFO - 'TERM': 'linux', 02:56:41 INFO - 'TMOUT': '86400', 02:56:41 INFO - 'USER': 'cltbld', 02:56:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:41 INFO - '_': '/tools/buildbot/bin/python'} 02:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:56:41 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 02:56:41 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 02:56:41 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 02:56:41 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 02:56:41 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 02:56:41 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 02:56:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:43 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 02:56:43 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 02:56:43 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 02:56:43 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 02:56:43 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 02:56:43 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 02:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:44 INFO - Downloading docopt-0.6.1.tar.gz 02:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:44 INFO - Running setup.py install for blobuploader 02:56:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:44 INFO - Running setup.py install for requests 02:56:44 INFO - Running setup.py install for docopt 02:56:44 INFO - Successfully installed blobuploader requests docopt 02:56:44 INFO - Cleaning up... 02:56:44 INFO - Return code: 0 02:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:44 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:44 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 02:56:44 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 02:56:44 INFO - Using env: {'DISPLAY': ':0', 02:56:44 INFO - 'HOME': '/home/cltbld', 02:56:44 INFO - 'LANG': 'en_US.UTF-8', 02:56:44 INFO - 'LANGUAGE': 'en_US:en', 02:56:44 INFO - 'LOGNAME': 'cltbld', 02:56:44 INFO - 'MAIL': '/var/mail/cltbld', 02:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:44 INFO - 'MOZ_NO_REMOTE': '1', 02:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:44 INFO - 'NO_EM_RESTART': '1', 02:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:44 INFO - 'PWD': '/builds/slave/test', 02:56:44 INFO - 'SHELL': '/bin/bash', 02:56:44 INFO - 'SHLVL': '1', 02:56:44 INFO - 'TERM': 'linux', 02:56:44 INFO - 'TMOUT': '86400', 02:56:44 INFO - 'USER': 'cltbld', 02:56:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:44 INFO - '_': '/tools/buildbot/bin/python'} 02:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:45 INFO - Running setup.py (path:/tmp/pip-PRjQG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:45 INFO - Running setup.py (path:/tmp/pip-foAzkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:45 INFO - Running setup.py (path:/tmp/pip-grGbp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:45 INFO - Running setup.py (path:/tmp/pip-4yfNqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:45 INFO - Running setup.py (path:/tmp/pip-2uAWZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:45 INFO - Running setup.py (path:/tmp/pip-jFKqNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:45 INFO - Running setup.py (path:/tmp/pip-Yi2iCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:45 INFO - Running setup.py (path:/tmp/pip-gUWiMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:45 INFO - Running setup.py (path:/tmp/pip-32qwdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:45 INFO - Running setup.py (path:/tmp/pip-ROnuNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:45 INFO - Running setup.py (path:/tmp/pip-AOyLgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:45 INFO - Running setup.py (path:/tmp/pip-JJJ1rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:46 INFO - Running setup.py (path:/tmp/pip-LANvsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:46 INFO - Running setup.py (path:/tmp/pip-vINwZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:46 INFO - Running setup.py (path:/tmp/pip-SKi7I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:46 INFO - Running setup.py (path:/tmp/pip-SZg8Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:46 INFO - Running setup.py (path:/tmp/pip-66ULd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:46 INFO - Running setup.py install for manifestparser 02:56:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:46 INFO - Running setup.py install for mozcrash 02:56:46 INFO - Running setup.py install for mozdebug 02:56:46 INFO - Running setup.py install for mozdevice 02:56:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:56:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:46 INFO - Running setup.py install for mozfile 02:56:46 INFO - Running setup.py install for mozhttpd 02:56:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozinfo 02:56:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozInstall 02:56:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozleak 02:56:47 INFO - Running setup.py install for mozlog 02:56:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for moznetwork 02:56:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozprocess 02:56:47 INFO - Running setup.py install for mozprofile 02:56:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozrunner 02:56:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:47 INFO - Running setup.py install for mozscreenshot 02:56:48 INFO - Running setup.py install for moztest 02:56:48 INFO - Running setup.py install for mozversion 02:56:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:48 INFO - Cleaning up... 02:56:48 INFO - Return code: 0 02:56:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:48 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:48 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 02:56:48 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 02:56:48 INFO - Using env: {'DISPLAY': ':0', 02:56:48 INFO - 'HOME': '/home/cltbld', 02:56:48 INFO - 'LANG': 'en_US.UTF-8', 02:56:48 INFO - 'LANGUAGE': 'en_US:en', 02:56:48 INFO - 'LOGNAME': 'cltbld', 02:56:48 INFO - 'MAIL': '/var/mail/cltbld', 02:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:48 INFO - 'MOZ_NO_REMOTE': '1', 02:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:48 INFO - 'NO_EM_RESTART': '1', 02:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:48 INFO - 'PWD': '/builds/slave/test', 02:56:48 INFO - 'SHELL': '/bin/bash', 02:56:48 INFO - 'SHLVL': '1', 02:56:48 INFO - 'TERM': 'linux', 02:56:48 INFO - 'TMOUT': '86400', 02:56:48 INFO - 'USER': 'cltbld', 02:56:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:48 INFO - '_': '/tools/buildbot/bin/python'} 02:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:48 INFO - Running setup.py (path:/tmp/pip-dpsEXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:48 INFO - Running setup.py (path:/tmp/pip-kU_cA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:48 INFO - Running setup.py (path:/tmp/pip-BQJtfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:48 INFO - Running setup.py (path:/tmp/pip-bNkzW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:48 INFO - Running setup.py (path:/tmp/pip-dhJyGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:48 INFO - Running setup.py (path:/tmp/pip-7PMo8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:48 INFO - Running setup.py (path:/tmp/pip-cFrsGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:48 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)) 02:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:48 INFO - Running setup.py (path:/tmp/pip-fPKg8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:49 INFO - Running setup.py (path:/tmp/pip-4x0bb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:49 INFO - Running setup.py (path:/tmp/pip-YBaGLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:49 INFO - Running setup.py (path:/tmp/pip-QxkQlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:49 INFO - Running setup.py (path:/tmp/pip-X87FEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:49 INFO - Running setup.py (path:/tmp/pip-x4bu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:49 INFO - Running setup.py (path:/tmp/pip-W54PhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:49 INFO - Running setup.py (path:/tmp/pip-7YLROO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:49 INFO - Running setup.py (path:/tmp/pip-f5og6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:49 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)) 02:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:49 INFO - Running setup.py (path:/tmp/pip-5CRy_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:49 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)) 02:56:49 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)) 02:56:49 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)) 02:56:49 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)) 02:56:49 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)) 02:56:49 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)) 02:56:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:51 INFO - Downloading blessings-1.6.tar.gz 02:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:51 INFO - Installing collected packages: blessings 02:56:51 INFO - Running setup.py install for blessings 02:56:51 INFO - Successfully installed blessings 02:56:51 INFO - Cleaning up... 02:56:51 INFO - Return code: 0 02:56:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:52 INFO - Reading from file tmpfile_stdout 02:56:52 INFO - Current package versions: 02:56:52 INFO - argparse == 1.2.1 02:56:52 INFO - blessings == 1.6 02:56:52 INFO - blobuploader == 1.2.4 02:56:52 INFO - docopt == 0.6.1 02:56:52 INFO - functools32 == 3.2.3-2 02:56:52 INFO - jsonschema == 2.5.1 02:56:52 INFO - manifestparser == 1.1 02:56:52 INFO - mozInstall == 1.12 02:56:52 INFO - mozcrash == 0.17 02:56:52 INFO - mozdebug == 0.1 02:56:52 INFO - mozdevice == 0.48 02:56:52 INFO - mozfile == 1.2 02:56:52 INFO - mozhttpd == 0.7 02:56:52 INFO - mozinfo == 0.9 02:56:52 INFO - mozleak == 0.1 02:56:52 INFO - mozlog == 3.2 02:56:52 INFO - moznetwork == 0.27 02:56:52 INFO - mozprocess == 0.22 02:56:52 INFO - mozprofile == 0.28 02:56:52 INFO - mozrunner == 6.11 02:56:52 INFO - mozscreenshot == 0.1 02:56:52 INFO - mozsystemmonitor == 0.3 02:56:52 INFO - moztest == 0.7 02:56:52 INFO - mozversion == 1.4 02:56:52 INFO - psutil == 3.1.1 02:56:52 INFO - requests == 1.2.3 02:56:52 INFO - wsgiref == 0.1.2 02:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:52 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 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:52 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 02:56:52 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 02:56:52 INFO - Using env: {'DISPLAY': ':0', 02:56:52 INFO - 'HOME': '/home/cltbld', 02:56:52 INFO - 'LANG': 'en_US.UTF-8', 02:56:52 INFO - 'LANGUAGE': 'en_US:en', 02:56:52 INFO - 'LOGNAME': 'cltbld', 02:56:52 INFO - 'MAIL': '/var/mail/cltbld', 02:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:52 INFO - 'MOZ_NO_REMOTE': '1', 02:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:52 INFO - 'NO_EM_RESTART': '1', 02:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:52 INFO - 'PWD': '/builds/slave/test', 02:56:52 INFO - 'SHELL': '/bin/bash', 02:56:52 INFO - 'SHLVL': '1', 02:56:52 INFO - 'TERM': 'linux', 02:56:52 INFO - 'TMOUT': '86400', 02:56:52 INFO - 'USER': 'cltbld', 02:56:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:52 INFO - '_': '/tools/buildbot/bin/python'} 02:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 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)) 02:56:52 INFO - Cleaning up... 02:56:52 INFO - Return code: 0 02:56:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:56:52 INFO - Using env: {'DISPLAY': ':0', 02:56:52 INFO - 'HOME': '/home/cltbld', 02:56:52 INFO - 'LANG': 'en_US.UTF-8', 02:56:52 INFO - 'LANGUAGE': 'en_US:en', 02:56:52 INFO - 'LOGNAME': 'cltbld', 02:56:52 INFO - 'MAIL': '/var/mail/cltbld', 02:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:52 INFO - 'MOZ_NO_REMOTE': '1', 02:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:52 INFO - 'NO_EM_RESTART': '1', 02:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:52 INFO - 'PWD': '/builds/slave/test', 02:56:52 INFO - 'SHELL': '/bin/bash', 02:56:52 INFO - 'SHLVL': '1', 02:56:52 INFO - 'TERM': 'linux', 02:56:52 INFO - 'TMOUT': '86400', 02:56:52 INFO - 'USER': 'cltbld', 02:56:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:52 INFO - '_': '/tools/buildbot/bin/python'} 02:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:52 INFO - Cleaning up... 02:56:52 INFO - Return code: 0 02:56:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff029555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', '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 02:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:56:52 INFO - Using env: {'DISPLAY': ':0', 02:56:52 INFO - 'HOME': '/home/cltbld', 02:56:52 INFO - 'LANG': 'en_US.UTF-8', 02:56:52 INFO - 'LANGUAGE': 'en_US:en', 02:56:52 INFO - 'LOGNAME': 'cltbld', 02:56:52 INFO - 'MAIL': '/var/mail/cltbld', 02:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:52 INFO - 'MOZ_NO_REMOTE': '1', 02:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:52 INFO - 'NO_EM_RESTART': '1', 02:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:52 INFO - 'PWD': '/builds/slave/test', 02:56:52 INFO - 'SHELL': '/bin/bash', 02:56:52 INFO - 'SHLVL': '1', 02:56:52 INFO - 'TERM': 'linux', 02:56:52 INFO - 'TMOUT': '86400', 02:56:52 INFO - 'USER': 'cltbld', 02:56:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:52 INFO - '_': '/tools/buildbot/bin/python'} 02:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:52 INFO - Downloading/unpacking flake8 02:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:56:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:56:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:54 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 02:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:55 INFO - no previously-included directories found matching 'docs/_build' 02:56:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:56:55 INFO - Running setup.py install for pep8 02:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:55 INFO - no previously-included directories found matching 'docs/_build' 02:56:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:56:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:56:55 INFO - Cleaning up... 02:56:55 INFO - Return code: 0 02:56:55 INFO - Running post-action listener: _resource_record_post_action 02:56:55 INFO - Running post-action listener: _start_resource_monitoring 02:56:55 INFO - Starting resource monitoring. 02:56:55 INFO - ##### 02:56:55 INFO - ##### Finished create-virtualenv step (success) 02:56:55 INFO - ##### 02:56:55 INFO - ##### 02:56:55 INFO - ##### Running install step. 02:56:55 INFO - ##### 02:56:55 INFO - Running pre-action listener: _resource_record_pre_action 02:56:55 INFO - Running main action method: install 02:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:55 INFO - Reading from file tmpfile_stdout 02:56:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:55 INFO - Reading from file tmpfile_stdout 02:56:55 INFO - Output received: 02:56:55 INFO - Usage: mozinstall [options] installer 02:56:55 INFO - Options: 02:56:55 INFO - -h, --help show this help message and exit 02:56:55 INFO - -d DEST, --destination=DEST 02:56:55 INFO - Directory to install application into. [default: 02:56:55 INFO - "/builds/slave/test"] 02:56:55 INFO - --app=APP Application being installed. [default: firefox] 02:56:55 INFO - mkdir: /builds/slave/test/build/application 02:56:55 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'] 02:56:55 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 02:57:11 INFO - Reading from file tmpfile_stdout 02:57:11 INFO - Output received: 02:57:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - ##### 02:57:11 INFO - ##### Finished install step (success) 02:57:11 INFO - ##### 02:57:11 INFO - ##### 02:57:11 INFO - ##### Running run-tests step. 02:57:11 INFO - ##### 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: run_tests 02:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:11 INFO - Python 2.7.3 02:57:11 INFO - Return code: 0 02:57:11 INFO - grabbing minidump binary from tooltool 02:57:11 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')]} 02:57:11 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 0x124b1c0>, '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 0x124c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:11 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 02:57:11 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 02:57:11 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 02:57:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:11 INFO - Return code: 0 02:57:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:57:12 INFO - Return code: 0 02:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:57:12 INFO - Using env: {'DISPLAY': ':0', 02:57:12 INFO - 'HOME': '/home/cltbld', 02:57:12 INFO - 'LANG': 'en_US.UTF-8', 02:57:12 INFO - 'LANGUAGE': 'en_US:en', 02:57:12 INFO - 'LOGNAME': 'cltbld', 02:57:12 INFO - 'MAIL': '/var/mail/cltbld', 02:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:12 INFO - 'MOZ_NO_REMOTE': '1', 02:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:12 INFO - 'NO_EM_RESTART': '1', 02:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:12 INFO - 'PWD': '/builds/slave/test', 02:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:12 INFO - 'SHELL': '/bin/bash', 02:57:12 INFO - 'SHLVL': '1', 02:57:12 INFO - 'TERM': 'linux', 02:57:12 INFO - 'TMOUT': '86400', 02:57:12 INFO - 'USER': 'cltbld', 02:57:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803', 02:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:12 INFO - '_': '/tools/buildbot/bin/python'} 02:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:57:13 INFO - mozversion application_buildid: 20160610021229 02:57:13 INFO - mozversion application_changeset: c69b3fef9219c2da558d92246796df38be793593 02:57:13 INFO - mozversion application_display_name: Nightly 02:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:13 INFO - mozversion application_name: Firefox 02:57:13 INFO - mozversion application_remotingname: firefox 02:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:57:13 INFO - mozversion application_vendor: Mozilla 02:57:13 INFO - mozversion application_version: 50.0a1 02:57:13 INFO - mozversion platform_buildid: 20160610021229 02:57:13 INFO - mozversion platform_changeset: c69b3fef9219c2da558d92246796df38be793593 02:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:57:13 INFO - mozversion platform_version: 50.0a1 02:57:13 INFO - using testdate: 1465552633 02:57:13 INFO - actual date: 1465552633 02:57:13 INFO - starting webserver on 'localhost:60894' 02:57:13 INFO - SUITE-START | Running 2 tests 02:57:13 INFO - TEST-START | dromaeo_css 02:57:13 INFO - operating with platform_type : linux_ 02:57:13 INFO - Initialising browser for dromaeo_css test... 02:57:13 INFO - TEST-INFO | started process 6180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeARENz/profile http://localhost:60894/getInfo.html) 02:57:18 INFO - PROCESS | 6180 | __metrics Screen width/height:1600/1200 02:57:18 INFO - PROCESS | 6180 | colorDepth:24 02:57:18 INFO - PROCESS | 6180 | Browser inner width/height: 1024/697 02:57:18 INFO - PROCESS | 6180 | __metrics 02:57:18 ERROR - PROCESS | 6180 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:57:19 INFO - TEST-INFO | 6180: exit 0 02:57:19 INFO - Browser initialized. 02:57:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:19 INFO - TEST-INFO | started process 6300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeARENz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:31 INFO - PROCESS | 6300 | RSS: Main: 185774080 02:57:31 INFO - PROCESS | 6300 | 02:58:21 INFO - PROCESS | 6300 | 1465552701520 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] 03:00:33 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60894/tests/dromaeo/cssquery-ext.html) 03:00:34 INFO - PROCESS | 6300 | RSS: Main: 189091840 03:00:34 INFO - PROCESS | 6300 | 03:03:36 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-ext.html (next: http://localhost:60894/tests/dromaeo/cssquery-jquery.html) 03:03:37 INFO - PROCESS | 6300 | RSS: Main: 187846656 03:03:37 INFO - PROCESS | 6300 | 03:06:39 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60894/tests/dromaeo/cssquery-mootools.html) 03:06:39 INFO - PROCESS | 6300 | RSS: Main: 189276160 03:06:39 INFO - PROCESS | 6300 | 03:09:41 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60894/tests/dromaeo/cssquery-prototype.html) 03:09:42 INFO - PROCESS | 6300 | RSS: Main: 186441728 03:09:42 INFO - PROCESS | 6300 | 03:12:44 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60894/tests/dromaeo/cssquery-yui.html) 03:12:45 INFO - PROCESS | 6300 | RSS: Main: 187899904 03:12:45 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | Cycle 1(1): loaded http://localhost:60894/tests/dromaeo/cssquery-yui.html (next: http://localhost:60894/tests/dromaeo/cssquery-dojo.html) 03:15:48 INFO - PROCESS | 6300 | RSS: Main: 189546496 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | __start_tp_report 03:15:48 INFO - PROCESS | 6300 | _x_x_mozilla_page_load 03:15:48 INFO - PROCESS | 6300 | _x_x_mozilla_page_load_details 03:15:48 INFO - PROCESS | 6300 | |i|pagename|runs| 03:15:48 INFO - PROCESS | 6300 | |0;dojo.html;2574.3178057814675;2664.054260737438;2670.279024663341;2680.463907218554;2690.529157397455;4779.450363208228;4797.184478638631;4809.01415209882;4878.341423907771;4947.653664243504;4729.1251118543005;4845;4860.173770459021;4870.610351171907;4874.951250487494;4418.5360537143615;4453.28747400416;4544.818207271722;4565.61192298655;4577.793999270041;4258.9148217035645;4532.977335113336;4548.113117942003;4637.28122141067;4640.9535904641025;4292.29177185764;4408.338749187616;4444.044530425974;4446.377507149002;4515.6613254005915;4407.845725399628;4469.329600559942;4532.388127602798;4536.7504787236685;4539.455265368144;4493.078918821667;4505.842295519641;4519;4531.13908357411;4552.840650577247;4756;4837.7339246341435;4844.224924012141;4861.829835955725;4871.29366241893;5197;5197.766100525448;5205.505476979719;5212.556932660728;5242.370915490127;4967.478414766434;5197.402298735618;5234.528892399702;5235.240890070956;5239.711815850127;4901.166801643729;4908.950910490921;4926.5073492650445;4933.210686290176;4983.053219888209;5408.8377348679605;5415.458454154632;5418.756155972991;5421.864453388697;5467.152591348347;4889.926651100236;5081.3140226069745;5125.974370128126;5187.377514698261;5197.558207552401;5000.149974504343;5243.4232234454175;5270.631055826056;5270.894582108336;5297.7880884764945;5123.231515272739;5131.974340128276;5178.663386879841;5193.844184674465;5207.3490813648295;4902.950970490321;5024.447310795809;5127.794888204505;5179.533841954242;5184.611154163453;4382.452193475816;4386.956130438719;4420.359047938031;4450.310201918708;4461.442319710036;3818.4272359145793;3834.9808250959127;3840.558335791364;3841;3909.9022524436546;4247.044415006599;4415.050764085737;4458.977705111453;4463.575960283768;4497.235469970113;5215.530602245816;5248.343957005374;5254.316938798008;5268.4994925482015;5300.2049692546425;4493;4503.234450143484;4508.909821803545;4543.295789152687;4548.999220171557;4516.458025037016;4680.368150299666;4680.391549098664;4685.554872287127;4706.552877476634;4867.488913664156;4905.3132561441425;4915.877103072452;4927.162382394929;4974.552290293891;5252.684838909678;5258.710770907637;5270.868228294324;5275.103232450416;5284.339457567804;4839.927401088916;4874.073925954058;4887.682300650446;4900.093482705711;4913.606911447004;5120.206368012964;5152.124138896472;5162.328897243335;5175.301334319819;5212.895742085213;4980.576650984707;5111.795528178831;5219.686818790885;5242.292290540729;5247.475252474875;4771.475137734916;4978.502149784992;4982.202847544376;5051.06555287273;5102.540771330449;5035.5719763819025;5050.646454748133;5052.040112378636;5056.241563765465;5061.848144555669;4720.5043470436485;4958.42978057528;4984.40187177541;5001.549860512571;5017.397912250407;4859;5101.285819985131;5133.743312834418;5156.4070131935305;5229.189475631283;5021.07110184617;5052.444231134646;5060.089183946778;5060.924086138637;5099.464556221692 03:15:48 INFO - PROCESS | 6300 | |1;ext.html;547.2092825866623;569.4874612848436;592.8458600763803;597.2981746447923;605.1497645807639;34980.12549686256;38983;38998;39026.80486597563;39040.609593904126;40162.59837401625;40731;40760.38859417111;40800.59199408005;40909;7699.576523291231;7745.961270193641;7772.689092436296;7845.137034926153;7873.881891771599;7662.310392064713;7744.806379840521;7766.106897706752;7779.533228006309;7834.608269586526;7849.372050235996;7850.175731548191;7879.763607091796;7884.684612615489;7884.974953256069;7759.573223472707;7812.257835505618;7815.218478152167;7815.6482958267015;7819.804504887366;7766.922330776676;7796.883046754303;7854;7855.7250496232355;7855.882161767521;36806.07984800375;37105.25789484222;37125;37184;37330.066748331235;2815.81697189682;3042.6957304269395;3063.6017317748774;3116.205367631262;3355.748318876094;28872.171449096095;28904.71095289041;29147.41705165906;29176;29399;2895.8986435474867;2909.3890283040587;2911.083008852205;2927.5901373807683;2973.4499117663086;259379;259438;261362;261980;262314.68842655857;31752.523712144335;52836.471635283924;52914;53454;53514.197287040726;31615.73537058538;33794;33939.32121357559;33956.66043339535;33992.150196244795;12669.366531673379;12739.745205095845;12771.10602257833;12773;12778;10419.791604167875;10478.790424191626;10485.266031377883;10528.36829790215;10543.947280263703;7894.447388682852;7910.881336779953;7913.44605877583;7936.6031698414845;7964.721234756756;3109.9689003110134;3153;3188.9681103189137;3202.327511222623;3210.197450637341;851.5614458553849;881.8280435315052;897.7710683775596;915.771057235691;977.8191034658611;27417.86291068532;27846.443071138463;28402.43195136127;28537.857310713312;28783;991.9107280344804;1004.7287232447344;1005.7485628592851;1043.441758659129;1091.350646365427;14664.633384165481;15049.54851354461;15079.095254284777;15125.773113403307;15462.922685386726;395285;395720;399054;400325;401045;49950.750246248535;50241;50313.74843125761;50633;50805.23792143121;1178.6117491337911;1211.666791632308;1228.7419641875306;1235.4193529041336;1240.9813852792215;25858.741412586387;27777.305567360978;27936.580951286152;28016.29959251035;28415.857920710263;42919.7854010728;42931.7853410731;43243;43243.78378108089;43337.78331108324;333311;336097;336355;337337;337446;25104.748952510243;25287.494250115262;25312.620310695722;25509.744902550738;25668.614970775827;41380.79309603433;41615.37576936409;41985.950351240244;42188;42917.78541107274;35983.46024809578;36251.81874090613;36458.8177059113;36579.26841463209;36692.266154676225;35312.82343588266;35453.46819797757;35737.64262357447;35796.105097372776;36628;33035.33929321352;35478.46782298319;35836.28327433489;36005.45991810073;36230;30965.380692385577;32101.518477223326;32258.83870580632;32276.83861580677;32473.837630811693;24881.377965551004;24891.502169956137;24927.376815579755;25453.3636659085;25509.2491188949 03:15:48 INFO - PROCESS | 6300 | |2;jquery.html;349.196847251322;352.36925902634295;354.92014296783225;368.13671939302327;370.2502432574037;15750.92124539377;16540.42108526202;17667.204975776105;17720;17735.46793596191;15810.920945395286;15960;16737.079460629662;16843.494695159166;16908.323667053333;4943.777530011149;5164.535191832734;5184.455632158607;5214.634975551713;5220.686758794465;3115.8286294253808;5093.567046801027;5724.398938111501;6062.484688801457;6068.059450785136;6035.366286539916;6037.909431358533;6041.395860413945;6051.697415129248;6118.755249790025;5741.368449470555;5990.430909063632;6006.789762358297;6019.518438524951;6021.548383871227;4962.206047032493;5176.275321454999;5232.555232805216;5240.3187585614005;5248.0553500369915;19653;20020;20212.595748084957;20279.797202027938;20474.488137796525;1857.6934805757035;1963.1950900130878;2211.9115235390727;2278.2026290798253;2305.4927915858484;13070.86929130706;13167.341632918316;13203;13448.394822233024;13692.794608080887;1691.8392752688476;1732.0819965418348;1738.2873022060894;1741.738739189119;1769.761082253892;64241.357586424005;64728;64772.352276477104;65731.342686573;66212;8456.746297611082;8657.39398242117;8853.64585416589;8967.730968070968;9063.456192628464;11457.484413201426;11464.54141834334;11496.94251528737;11605.129615278718;11760.764784704257;6910.44716422685;6938.653067346713;7253.1296244451005;7386.741464048732;7472.402207823361;7397.667104980289;7421.73830448825;7496.925030749731;7518.097828260644;7616.124145723202;5677.403872593318;5701.572382071361;5779.335376431764;5806.709664516758;5819.767209311664;1496.7156240314305;1573.7403328450907;1582.6913751818286;1621.7729517867508;1652.2317122538077;828.1759649149014;862.2670729879552;882.6381183714775;901.2834796336797;932.4079209701753;16120.838791611934;16514.58713532147;16688;16932.746008809878;17055.573610659834;836.4186890111314;892.4199270474244;907.1427501011481;922.4188761080476;941.6186444489992;9648.469334186546;9649.997766893428;9650.179734722487;9696.95151524238;9868.950655246677;370913;373636;373881;375034;387770;52039.479605203465;63651;63901;64143.67928160329;65133;875.991240087591;892.2103938014903;903.0563061600643;912.0696889173139;933.8972713001428;14913.552593422215;15018.474353397578;15139.697206056038;15258.618534536725;15268.465603703817;23040.769592304532;23060.654090188997;29635.85182074162;33619.15952101119;33813.3237335247;42362.5763742371;42437;43955.560444395145;44311.33532997072;44652.77673611611;7233.819154520968;7355.190928997913;7364.631768411665;7371.668274927749;7655.081390232985;11847;11924.880751192377;11986.880131198925;12105.51577936908;12175.269483830998;9957.850632240377;10211.081002709792;10374.118199952787;10501.89498105009;10567;10228.897711022795;10442.738931526772;10513.158947284046;10530.36817790935;10642.574297028032;9543.093406126407;10168.49157542105;10196.796064078826;10202.846957295795;10484.21368397358;7073.929260707327;7108.0759501266575;7154.499185056996;7166.498345116001;7239.819004524929;9418.576164072496;9516.19112375456;9562.091601297865;9647.469389183661;9696.17582505495 03:15:48 INFO - PROCESS | 6300 | |3;mootools.html;1374.7113106247687;1405.5713007532704;1454.893324431246;1631.7715519827234;1634.648550561629;6526.836829079275;7325.5970921599355;7504.924950750491;7960.800979975496;7972.960135199323;7642.5796581188015;7813.570253636062;7825.256600622932;7847.1368149503505;7895.842083158348;2135.1459416233515;2183.9890800545977;2184.1045171479695;2186.355025267542;2187.3765976696645;2130.7869213078725;2172.8587641803233;2186.6610675345346;2189.828441783646;2191.41927389242;2166.144372972675;2168.29530402619;2182.530755887492;2184.6941428200066;2189.4854709143337;2118.2162599838002;2118.290372725139;2127.946801329964;2131.7761635028255;2140.357892632212;2064.762552306489;2078.1375729072415;2103.0536258683655;2107.251925566417;2113.1124927530473;7793.908852760618;7795.961020194919;7811.453198276123;7880.0937892142565;7925.405594580372;4522.841700540465;4594.989102397467;4625.375574297461;4641.071785642885;4663.463701674317;2794.3153927287944;2840.261532001674;2889.4510043091955;2900;2912.810667306618;854.5897968974926;857.2670366836328;903.2142036428284;911.7811725185908;914.085914085914;10317.277790554665;10392.79214415715;10404.115650169744;10419;10431.530581123792;4064.695147863863;4173.499180098347;4232.534421213664;4261.785391163504;4275;8985.191332780081;9032.63869445228;9056.184943354998;9071.546422678839;9095.090490950852;4350.238708226111;4407.493138289074;4445.066536027406;4560.110778398247;4566.543345665474;3392.7794693344854;3912.4326972589383;4025.939610905839;4032.4556184915245;4042.4744783178;3557.4841647961416;3592.8742494012586;3673.1918977824835;3702.629737026276;3714.461403096536;1122.2088427658482;1175.1773758369177;1185.6917201527665;1202.0804084875078;1202.5129822421934;665.4410295351928;684.6610927590775;706.0468367703559;774.7094839435211;837.2046555772041;4884.096442158212;4929.802807887716;4986.626003049786;5017.046761115376;5096.566791822663;398.6551632837633;402.822757986485;410.69403294545754;414.50466692303013;418.5939638550601;3391.4690053817217;3519.542459480251;3661.3226553087766;3718.3307004738867;3730.5896351401325;9571.90428095724;9615.759606009906;9704.369216000938;9759.756006099904;9835.75410614726;9446.197073248713;9535.61857525705;9566.808663826823;9619;9628.374155679858;7197.89203161953;7274.963625181946;7338.376238019721;7360.926390736131;7365.410767138616;5061.620378471555;5120.641555091108;5184.31860609832;5200.115980283436;5399.190121481809;8641.351898607756;8684.826303473768;8698.086700896314;8834.514101724468;8886.955565222133;8710.172533609297;8917.152870477294;8959.283257339266;9028.729138125867;9070.092990700878;5588.888222235614;6181.84545386369;6377.617342959437;6546.967265163644;6649.63427011519;7238.420926325776;7286.562806231643;7313.707451702086;7360.374368178765;7408.740694075682;6549.639769812706;6778.627175505198;6834.350736680008;6838.93161068383;6850.828729281808;6604.240512341143;6658.5671931324305;6696.59820410777;6705.832354191184;6745.5952642841585;6098.207233059674;6142.938570614416;6144.723487442986;6152.600080994721;6157.261128664589;4231.407602935653;4273.166732487135;4309.6552275818485;4404.053128577371;4408.404865343266;4159.542450330522;4274.722143060691;4310.568943105664;4332.458442694663;4346.326319420495 03:15:48 INFO - PROCESS | 6300 | |4;prototype.html;274.7774302814719;286.2500249346712;289.403828114085;289.91447522980724;291.5393677988777;4931;5051.6716413433105;5085.4151772546165;5148.716820574867;5150.27035671094;5093;5097.974510127454;5120.667156634816;5121.3342265505435;5131.177852181304;3956.3076461619103;3970.960290397088;3979.5622481527007;3981.343078392069;4003.2393845169327;3927.8428862845453;4004.7997600120025;4009.6992725545556;4038.9394159087637;4046.2514434829504;3900.473436086135;3935.1539419024903;3940.192260586587;3948.8617898373564;3960.9009774755573;3896.9220615587815;3900.7854567998747;3919.647231749142;3927.4894263745673;3940.093778430948;3498.3877821381157;3505.982470087659;3511.3855075361967;3518.9120271993406;3548.929021419583;4904.337914381548;4969.676970996909;4999.800047988493;5031.371078615173;5053.469385714484;4529.5243999380245;4550.13547425988;4553.362529245908;4567.954320456786;4571.6114130298965;5344.251804747339;5347.732613369316;5372.435894231088;5392.272043274147;5404.243405923174;3726.273376691546;3781.2626537825136;3785.659290663826;3786.2427514496935;3804.2962052020466;5632.662040277596;5638.605297629168;5641.492265696107;5660.801871934504;5661.131826497287;3799.411091280856;3817.408301713239;3864.884053478344;3869.8258578364043;3870.825812838429;3712.480252764615;3918.7060970427333;3921.1961547882615;3925.9607403926166;3930.7248492605245;4450.421445212101;4469.173202957463;4475.48531918827;4475.597196252353;4508.18852606534;5364.8122315718765;5381.78472861089;5382.6585435335755;5410.48600382963;5459.754311056012;1240.9142000749343;1280.7000894092503;1319.2546211390725;1325.8740419660116;1339.3838834136407;847.5677404523738;850.9531975741394;860.423516244118;865.4590880699562;867.4274978514151;4106.67146628269;4148.62662360389;4160.3343465046055;4174.666026717855;4206.789660517024;4839.395075615548;4852.4662287148385;4858.348161625065;4860.392450943632;4862.610991120702;4209.97895010523;4214.662826973835;4235.221207093028;4249.022724773319;4260.147970405931;2497.5379554782426;2637.485690290375;2656.8405895646324;2677.7857771378244;2682.3830518980744;4669.743164125938;4674.462436819741;4674.813007479731;4682.461516925529;4689.124350259855;4928.359313289249;4953.603711703127;4960.206366981266;4979;5049.621278404061;4245.363195520635;4561.589456948891;4579.335996280587;4601.44782626087;4602.608778253886;4821.46963833985;4855.708657480563;4872.806162490213;4907.944791869765;4912.263160525949;4711.458182309078;4722.347178487639;4730.337752714691;4841.225403935354;4903.632227582874;4375.934360984524;4520.59314661682;4562.680612357236;4574.611158051603;4594.9310760339295;3500.544929159193;3516.2967406518287;3522.788632682047;3538.38078336285;3548.3435564419633;4797.976010119927;4831.043427411903;4836.041403231697;4941.332920055746;5194.922076168936;5243.764030618555;5335.67985920846;5336.412994570516;5344.759485823225;5380.73096345189;5303.36359636846;5315.973420132875;5359.490848369554;5369.275147855145;5435.320584926884;5178.741062946762;5248.895022099613;5267.683938963674;5289.603279754111;5306.814261500829;5388.326459192601;5394.78420863161;5406.945930540644;5409.459054094559;5409.891802163856;5216.991458288662;5244.318238628954;5262.394969534329;5267.841964741064;5270.973645131749 03:15:48 INFO - PROCESS | 6300 | |5;yui.html;546.6200990311735;555.7471350535507;561.4385614385615;610.8808782287455;615;11231.382273974928;12047.939760301186;12117;12148.088893332992;12174.81737773934;12271.877281227185;12887.291198984076;12915.354232288395;13361;13521.797173042412;617.6170774120052;781.0822283816507;782.7338704840353;785.4030936488282;785.9489133206351;750.3434494817035;774.7211004038542;774.8062984253936;778.2023425988378;779.3453499060788;813.7965508622844;820.5938060659981;825.8637324841424;827.1893544326564;827.4497459189631;818.3657665309373;818.423011776696;820.4502983001404;820.8317294954579;822.62159406673;597.0268462406293;597.4592993341033;601.5097695378297;601.572883252891;603.1495591216408;10962.506687199095;11037.392943388111;11066.502007409686;11105.222634415593;11130.49912753928;11999.280043197436;12304.569340073054;12800.295983720891;12945.87054129456;12946.741065178643;9260.39807412516;9262.6294948202;9283;9800.754981125529;9958.25313101513;3123.5470856725874;3154.668759780236;3176.444122278592;3179.205198700325;3219.919502012445;51594.484055159344;51867.22199167016;51892.48107518952;52801;53521.46478535243;9151.359404841598;9166.67916622915;9198.540072996324;9210.769730756785;9217.907820921839;18149;18358.54103647393;18386.724199137025;18487.445376638723;18603.162857671436;6255.873942690268;6417.743290268337;6647.767328143588;6730.461563074942;6809.114815074107;3304.1078908694517;3437.6906078453057;3474.583050034012;3530.135116896377;3558.09268636496;2726.8363898165776;2825.1242114944434;2845.4593627210766;2851.586519954595;2856.40015596727;464.0695405711594;473.6826326361277;482.22361997184504;485.53388746802756;486.8077109541711;395.3693858296071;461.50618837843854;497.86557629440574;506.5357038010128;550.2873778456908;6792.150981127359;6946.7221311148;7027;7050.753223637148;7179.748708795167;452.39605127155613;507.91813437378886;509.959203263738;515.9037046276662;535.4404647143745;3363.9327213455595;3442.4836274559016;3453.671901169385;3539.2213712983103;3553.6673747344744;80394.59802701067;82377.17622823695;83551.16448835556;85619;86463;49832.750836245585;66793.3320666787;76126;77612.61193694109;79115.60442197752;70751.2924870755;72915.2708472919;73510.63244683742;73654.63172684102;73665.26334736691;6518.771842985473;6524.706388212637;6568.1789776277965;6704.430123439367;6797.28628494001;37293.440598391586;38452.42321365126;41590.792046040784;42549.57450425456;43640.78179609209;60059.39940600538;60101.699491502266;60623;60646.69676651589;61282;9914.058164474363;10105.29882840705;10428.530716117944;10483.79032419332;10893.56425742993;10192.847107293544;10360.326578772658;10622.415767132881;10658.467076645982;11158.944205278922;10273.280870339304;10318.277720559488;10331.535080921227;10404.68785936423;10743.731406714895;9912.900870991198;10109.545070471699;10157.339772914736;10187.439690817077;10213;9572.760680982752;9703.757406064904;9717.902820971982;9953.452560109263;10020.64927727526;8828.337874659297;8999.325050621099;9201.953990230273;9404.529773511435;9667;8731.476111433334;8835.823283534164;8842.46945183291;9048.095190480899;9078.45529268246 03:15:48 INFO - PROCESS | 6300 | __end_tp_report 03:15:48 INFO - PROCESS | 6300 | __start_cc_report 03:15:48 INFO - PROCESS | 6300 | _x_x_mozilla_cycle_collect,390 03:15:48 INFO - PROCESS | 6300 | __end_cc_report 03:15:48 INFO - PROCESS | 6300 | __startTimestamp1465553748294__endTimestamp 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | ------- Summary: start ------- 03:15:48 INFO - PROCESS | 6300 | Number of tests: 6 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#0] dojo.html Cycles:165 Average:4805.46 Median:4913.61 stddev:515.22 (10.5%) stddev-sans-first:486.16 03:15:48 INFO - PROCESS | 6300 | Values: 2574.3 2664.1 2670.3 2680.5 2690.5 4779.5 4797.2 4809.0 4878.3 4947.7 4729.1 4845.0 4860.2 4870.6 4875.0 4418.5 4453.3 4544.8 4565.6 4577.8 4258.9 4533.0 4548.1 4637.3 4641.0 4292.3 4408.3 4444.0 4446.4 4515.7 4407.8 4469.3 4532.4 4536.8 4539.5 4493.1 4505.8 4519.0 4531.1 4552.8 4756.0 4837.7 4844.2 4861.8 4871.3 5197.0 5197.8 5205.5 5212.6 5242.4 4967.5 5197.4 5234.5 5235.2 5239.7 4901.2 4909.0 4926.5 4933.2 4983.1 5408.8 5415.5 5418.8 5421.9 5467.2 4889.9 5081.3 5126.0 5187.4 5197.6 5000.1 5243.4 5270.6 5270.9 5297.8 5123.2 5132.0 5178.7 5193.8 5207.3 4903.0 5024.4 5127.8 5179.5 5184.6 4382.5 4387.0 4420.4 4450.3 4461.4 3818.4 3835.0 3840.6 3841.0 3909.9 4247.0 4415.1 4459.0 4463.6 4497.2 5215.5 5248.3 5254.3 5268.5 5300.2 4493.0 4503.2 4508.9 4543.3 4549.0 4516.5 4680.4 4680.4 4685.6 4706.6 4867.5 4905.3 4915.9 4927.2 4974.6 5252.7 5258.7 5270.9 5275.1 5284.3 4839.9 4874.1 4887.7 4900.1 4913.6 5120.2 5152.1 5162.3 5175.3 5212.9 4980.6 5111.8 5219.7 5242.3 5247.5 4771.5 4978.5 4982.2 5051.1 5102.5 5035.6 5050.6 5052.0 5056.2 5061.8 4720.5 4958.4 4984.4 5001.5 5017.4 4859.0 5101.3 5133.7 5156.4 5229.2 5021.1 5052.4 5060.1 5060.9 5099.5 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#1] ext.html Cycles:180 Average:47285.68 Median:35766.87 stddev:88892.31 (248.5%) stddev-sans-first:89072.41 03:15:48 INFO - PROCESS | 6300 | Values: 547.2 569.5 592.8 597.3 605.1 34980.1 38983.0 38998.0 39026.8 39040.6 40162.6 40731.0 40760.4 40800.6 40909.0 7699.6 7746.0 7772.7 7845.1 7873.9 7662.3 7744.8 7766.1 7779.5 7834.6 7849.4 7850.2 7879.8 7884.7 7885.0 7759.6 7812.3 7815.2 7815.6 7819.8 7766.9 7796.9 7854.0 7855.7 7855.9 36806.1 37105.3 37125.0 37184.0 37330.1 2815.8 3042.7 3063.6 3116.2 3355.7 28872.2 28904.7 29147.4 29176.0 29399.0 2895.9 2909.4 2911.1 2927.6 2973.4 259379.0 259438.0 261362.0 261980.0 262314.7 31752.5 52836.5 52914.0 53454.0 53514.2 31615.7 33794.0 33939.3 33956.7 33992.2 12669.4 12739.7 12771.1 12773.0 12778.0 10419.8 10478.8 10485.3 10528.4 10543.9 7894.4 7910.9 7913.4 7936.6 7964.7 3110.0 3153.0 3189.0 3202.3 3210.2 851.6 881.8 897.8 915.8 977.8 27417.9 27846.4 28402.4 28537.9 28783.0 991.9 1004.7 1005.7 1043.4 1091.4 14664.6 15049.5 15079.1 15125.8 15462.9 395285.0 395720.0 399054.0 400325.0 401045.0 49950.8 50241.0 50313.7 50633.0 50805.2 1178.6 1211.7 1228.7 1235.4 1241.0 25858.7 27777.3 27936.6 28016.3 28415.9 42919.8 42931.8 43243.0 43243.8 43337.8 333311.0 336097.0 336355.0 337337.0 337446.0 25104.7 25287.5 25312.6 25509.7 25668.6 41380.8 41615.4 41986.0 42188.0 42917.8 35983.5 36251.8 36458.8 36579.3 36692.3 35312.8 35453.5 35737.6 35796.1 36628.0 33035.3 35478.5 35836.3 36005.5 36230.0 30965.4 32101.5 32258.8 32276.8 32473.8 24881.4 24891.5 24927.4 25453.4 25509.2 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#2] jquery.html Cycles:180 Average:22990.55 Median:5027.89 stddev:61706.83 (1227.3%) stddev-sans-first:61856.52 03:15:48 INFO - PROCESS | 6300 | Values: 349.2 352.4 354.9 368.1 370.3 15750.9 16540.4 17667.2 17720.0 17735.5 15810.9 15960.0 16737.1 16843.5 16908.3 4943.8 5164.5 5184.5 5214.6 5220.7 3115.8 5093.6 5724.4 6062.5 6068.1 6035.4 6037.9 6041.4 6051.7 6118.8 5741.4 5990.4 6006.8 6019.5 6021.5 4962.2 5176.3 5232.6 5240.3 5248.1 19653.0 20020.0 20212.6 20279.8 20474.5 1857.7 1963.2 2211.9 2278.2 2305.5 13070.9 13167.3 13203.0 13448.4 13692.8 1691.8 1732.1 1738.3 1741.7 1769.8 64241.4 64728.0 64772.4 65731.3 66212.0 8456.7 8657.4 8853.6 8967.7 9063.5 11457.5 11464.5 11496.9 11605.1 11760.8 6910.4 6938.7 7253.1 7386.7 7472.4 7397.7 7421.7 7496.9 7518.1 7616.1 5677.4 5701.6 5779.3 5806.7 5819.8 1496.7 1573.7 1582.7 1621.8 1652.2 828.2 862.3 882.6 901.3 932.4 16120.8 16514.6 16688.0 16932.7 17055.6 836.4 892.4 907.1 922.4 941.6 9648.5 9650.0 9650.2 9697.0 9869.0 370913.0 373636.0 373881.0 375034.0 387770.0 52039.5 63651.0 63901.0 64143.7 65133.0 876.0 892.2 903.1 912.1 933.9 14913.6 15018.5 15139.7 15258.6 15268.5 23040.8 23060.7 29635.9 33619.2 33813.3 42362.6 42437.0 43955.6 44311.3 44652.8 7233.8 7355.2 7364.6 7371.7 7655.1 11847.0 11924.9 11986.9 12105.5 12175.3 9957.9 10211.1 10374.1 10501.9 10567.0 10228.9 10442.7 10513.2 10530.4 10642.6 9543.1 10168.5 10196.8 10202.8 10484.2 7073.9 7108.1 7154.5 7166.5 7239.8 9418.6 9516.2 9562.1 9647.5 9696.2 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#3] mootools.html Cycles:180 Average:5041.65 Median:4906.95 stddev:2872.32 (58.5%) stddev-sans-first:2867.16 03:15:48 INFO - PROCESS | 6300 | Values: 1374.7 1405.6 1454.9 1631.8 1634.6 6526.8 7325.6 7504.9 7960.8 7973.0 7642.6 7813.6 7825.3 7847.1 7895.8 2135.1 2184.0 2184.1 2186.4 2187.4 2130.8 2172.9 2186.7 2189.8 2191.4 2166.1 2168.3 2182.5 2184.7 2189.5 2118.2 2118.3 2127.9 2131.8 2140.4 2064.8 2078.1 2103.1 2107.3 2113.1 7793.9 7796.0 7811.5 7880.1 7925.4 4522.8 4595.0 4625.4 4641.1 4663.5 2794.3 2840.3 2889.5 2900.0 2912.8 854.6 857.3 903.2 911.8 914.1 10317.3 10392.8 10404.1 10419.0 10431.5 4064.7 4173.5 4232.5 4261.8 4275.0 8985.2 9032.6 9056.2 9071.5 9095.1 4350.2 4407.5 4445.1 4560.1 4566.5 3392.8 3912.4 4025.9 4032.5 4042.5 3557.5 3592.9 3673.2 3702.6 3714.5 1122.2 1175.2 1185.7 1202.1 1202.5 665.4 684.7 706.0 774.7 837.2 4884.1 4929.8 4986.6 5017.0 5096.6 398.7 402.8 410.7 414.5 418.6 3391.5 3519.5 3661.3 3718.3 3730.6 9571.9 9615.8 9704.4 9759.8 9835.8 9446.2 9535.6 9566.8 9619.0 9628.4 7197.9 7275.0 7338.4 7360.9 7365.4 5061.6 5120.6 5184.3 5200.1 5399.2 8641.4 8684.8 8698.1 8834.5 8887.0 8710.2 8917.2 8959.3 9028.7 9070.1 5588.9 6181.8 6377.6 6547.0 6649.6 7238.4 7286.6 7313.7 7360.4 7408.7 6549.6 6778.6 6834.4 6838.9 6850.8 6604.2 6658.6 6696.6 6705.8 6745.6 6098.2 6142.9 6144.7 6152.6 6157.3 4231.4 4273.2 4309.7 4404.1 4408.4 4159.5 4274.7 4310.6 4332.5 4346.3 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#4] prototype.html Cycles:180 Average:4255.68 Median:4672.10 stddev:1242.74 (26.6%) stddev-sans-first:1209.77 03:15:48 INFO - PROCESS | 6300 | Values: 274.8 286.3 289.4 289.9 291.5 4931.0 5051.7 5085.4 5148.7 5150.3 5093.0 5098.0 5120.7 5121.3 5131.2 3956.3 3971.0 3979.6 3981.3 4003.2 3927.8 4004.8 4009.7 4038.9 4046.3 3900.5 3935.2 3940.2 3948.9 3960.9 3896.9 3900.8 3919.6 3927.5 3940.1 3498.4 3506.0 3511.4 3518.9 3548.9 4904.3 4969.7 4999.8 5031.4 5053.5 4529.5 4550.1 4553.4 4568.0 4571.6 5344.3 5347.7 5372.4 5392.3 5404.2 3726.3 3781.3 3785.7 3786.2 3804.3 5632.7 5638.6 5641.5 5660.8 5661.1 3799.4 3817.4 3864.9 3869.8 3870.8 3712.5 3918.7 3921.2 3926.0 3930.7 4450.4 4469.2 4475.5 4475.6 4508.2 5364.8 5381.8 5382.7 5410.5 5459.8 1240.9 1280.7 1319.3 1325.9 1339.4 847.6 851.0 860.4 865.5 867.4 4106.7 4148.6 4160.3 4174.7 4206.8 4839.4 4852.5 4858.3 4860.4 4862.6 4210.0 4214.7 4235.2 4249.0 4260.1 2497.5 2637.5 2656.8 2677.8 2682.4 4669.7 4674.5 4674.8 4682.5 4689.1 4928.4 4953.6 4960.2 4979.0 5049.6 4245.4 4561.6 4579.3 4601.4 4602.6 4821.5 4855.7 4872.8 4907.9 4912.3 4711.5 4722.3 4730.3 4841.2 4903.6 4375.9 4520.6 4562.7 4574.6 4594.9 3500.5 3516.3 3522.8 3538.4 3548.3 4798.0 4831.0 4836.0 4941.3 5194.9 5243.8 5335.7 5336.4 5344.8 5380.7 5303.4 5316.0 5359.5 5369.3 5435.3 5178.7 5248.9 5267.7 5289.6 5306.8 5388.3 5394.8 5406.9 5409.5 5409.9 5217.0 5244.3 5262.4 5267.8 5271.0 03:15:48 INFO - PROCESS | 6300 | 03:15:48 INFO - PROCESS | 6300 | [#5] yui.html Cycles:180 Average:15947.08 Median:553.02 stddev:22559.68 (4079.4%) stddev-sans-first:22593.33 03:15:48 INFO - PROCESS | 6300 | Values: 546.6 555.7 561.4 610.9 615.0 11231.4 12047.9 12117.0 12148.1 12174.8 12271.9 12887.3 12915.4 13361.0 13521.8 617.6 781.1 782.7 785.4 785.9 750.3 774.7 774.8 778.2 779.3 813.8 820.6 825.9 827.2 827.4 818.4 818.4 820.5 820.8 822.6 597.0 597.5 601.5 601.6 603.1 10962.5 11037.4 11066.5 11105.2 11130.5 11999.3 12304.6 12800.3 12945.9 12946.7 9260.4 9262.6 9283.0 9800.8 9958.3 3123.5 3154.7 3176.4 3179.2 3219.9 51594.5 51867.2 51892.5 52801.0 53521.5 9151.4 9166.7 9198.5 9210.8 9217.9 18149.0 18358.5 18386.7 18487.4 18603.2 6255.9 6417.7 6647.8 6730.5 6809.1 3304.1 3437.7 3474.6 3530.1 3558.1 2726.8 2825.1 2845.5 2851.6 2856.4 464.1 473.7 482.2 485.5 486.8 395.4 461.5 497.9 506.5 550.3 6792.2 6946.7 7027.0 7050.8 7179.7 452.4 507.9 510.0 515.9 535.4 3363.9 3442.5 3453.7 3539.2 3553.7 80394.6 82377.2 83551.2 85619.0 86463.0 49832.8 66793.3 76126.0 77612.6 79115.6 70751.3 72915.3 73510.6 73654.6 73665.3 6518.8 6524.7 6568.2 6704.4 6797.3 37293.4 38452.4 41590.8 42549.6 43640.8 60059.4 60101.7 60623.0 60646.7 61282.0 9914.1 10105.3 10428.5 10483.8 10893.6 10192.8 10360.3 10622.4 10658.5 11158.9 10273.3 10318.3 10331.5 10404.7 10743.7 9912.9 10109.5 10157.3 10187.4 10213.0 9572.8 9703.8 9717.9 9953.5 10020.6 8828.3 8999.3 9202.0 9404.5 9667.0 8731.5 8835.8 8842.5 9048.1 9078.5 03:15:48 INFO - PROCESS | 6300 | -------- Summary: end -------- 03:15:48 INFO - PROCESS | 6300 | 03:15:49 INFO - TEST-INFO | 6300: exit 0 03:15:49 INFO - TEST-OK | dromaeo_css | took 1116132ms 03:15:49 INFO - TEST-START | kraken 03:15:49 INFO - operating with platform_type : linux_ 03:15:49 INFO - Initialising browser for kraken test... 03:15:49 INFO - TEST-INFO | started process 6540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBEuH2/profile http://localhost:60894/getInfo.html) 03:15:54 INFO - PROCESS | 6540 | __metrics Screen width/height:1600/1200 03:15:54 INFO - PROCESS | 6540 | colorDepth:24 03:15:54 INFO - PROCESS | 6540 | Browser inner width/height: 1024/697 03:15:54 INFO - PROCESS | 6540 | __metrics 03:15:54 ERROR - PROCESS | 6540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:15:55 INFO - TEST-INFO | 6540: exit 0 03:15:55 INFO - Browser initialized. 03:15:55 INFO - Running cycle 1/1 for kraken test... 03:15:55 INFO - TEST-INFO | started process 6658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppBEuH2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:08 INFO - PROCESS | 6658 | RSS: Main: 185225216 03:16:08 INFO - PROCESS | 6658 | 03:16:10 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60894/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:11 INFO - PROCESS | 6658 | RSS: Main: 189755392 03:16:11 INFO - PROCESS | 6658 | 03:16:14 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60894/tests/kraken/driver.html?testName=audio-dft) 03:16:15 INFO - PROCESS | 6658 | RSS: Main: 190119936 03:16:15 INFO - PROCESS | 6658 | 03:16:18 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60894/tests/kraken/driver.html?testName=audio-fft) 03:16:18 INFO - PROCESS | 6658 | RSS: Main: 185397248 03:16:18 INFO - PROCESS | 6658 | 03:16:20 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60894/tests/kraken/driver.html?testName=audio-oscillator) 03:16:21 INFO - PROCESS | 6658 | RSS: Main: 185724928 03:16:21 INFO - PROCESS | 6658 | 03:16:23 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:24 INFO - PROCESS | 6658 | RSS: Main: 185991168 03:16:24 INFO - PROCESS | 6658 | 03:16:27 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60894/tests/kraken/driver.html?testName=imaging-darkroom) 03:16:28 INFO - PROCESS | 6658 | RSS: Main: 186626048 03:16:28 INFO - PROCESS | 6658 | 03:16:31 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60894/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:32 INFO - PROCESS | 6658 | RSS: Main: 183730176 03:16:32 INFO - PROCESS | 6658 | 03:16:35 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60894/tests/kraken/driver.html?testName=json-parse-financial) 03:16:36 INFO - PROCESS | 6658 | RSS: Main: 185044992 03:16:36 INFO - PROCESS | 6658 | 03:16:37 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:38 INFO - PROCESS | 6658 | RSS: Main: 185212928 03:16:38 INFO - PROCESS | 6658 | 03:16:40 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:40 INFO - PROCESS | 6658 | RSS: Main: 185475072 03:16:40 INFO - PROCESS | 6658 | 03:16:43 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:43 INFO - PROCESS | 6658 | RSS: Main: 186175488 03:16:43 INFO - PROCESS | 6658 | 03:16:46 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:47 INFO - PROCESS | 6658 | RSS: Main: 186306560 03:16:47 INFO - PROCESS | 6658 | 03:16:50 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:50 INFO - PROCESS | 6658 | RSS: Main: 186011648 03:16:50 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | Cycle 1(1): loaded http://localhost:60894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60894/tests/kraken/driver.html?testName=ai-astar) 03:16:52 INFO - PROCESS | 6658 | RSS: Main: 186863616 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | __start_tp_report 03:16:52 INFO - PROCESS | 6658 | _x_x_mozilla_page_load 03:16:52 INFO - PROCESS | 6658 | _x_x_mozilla_page_load_details 03:16:52 INFO - PROCESS | 6658 | |i|pagename|runs| 03:16:52 INFO - PROCESS | 6658 | |0;ai-astar;116;108;115;116;115;116;115;116;114;115 03:16:52 INFO - PROCESS | 6658 | |1;audio-beat-detection;155;136;162;187;145;166;156;137;196;138 03:16:52 INFO - PROCESS | 6658 | |2;audio-dft;163;167;176;165;164;164;164;167;163;163 03:16:52 INFO - PROCESS | 6658 | |3;audio-fft;76;75;76;157;77;76;75;76;164;77 03:16:52 INFO - PROCESS | 6658 | |4;audio-oscillator;88;87;139;87;88;88;147;86;87;148 03:16:52 INFO - PROCESS | 6658 | |5;imaging-gaussian-blur;118;119;117;118;119;118;118;118;119;117 03:16:52 INFO - PROCESS | 6658 | |6;imaging-darkroom;148;149;148;147;147;149;148;148;147;148 03:16:52 INFO - PROCESS | 6658 | |7;imaging-desaturate;95;96;96;95;96;97;96;95;96;96 03:16:52 INFO - PROCESS | 6658 | |8;json-parse-financial;65;65;64;69;65;65;66;70;64;66 03:16:52 INFO - PROCESS | 6658 | |9;json-stringify-tinderbox;64;66;66;66;66;66;66;65;66;67 03:16:52 INFO - PROCESS | 6658 | |10;stanford-crypto-aes;86;83;83;84;87;86;87;85;114;86 03:16:52 INFO - PROCESS | 6658 | |11;stanford-crypto-ccm;140;147;143;146;141;132;135;137;155;135 03:16:52 INFO - PROCESS | 6658 | |12;stanford-crypto-pbkdf2;172;173;177;169;173;172;170;171;176;175 03:16:52 INFO - PROCESS | 6658 | |13;stanford-crypto-sha256-iterative;67;68;68;67;69;73;68;68;67;70 03:16:52 INFO - PROCESS | 6658 | __end_tp_report 03:16:52 INFO - PROCESS | 6658 | __start_cc_report 03:16:52 INFO - PROCESS | 6658 | _x_x_mozilla_cycle_collect,977 03:16:52 INFO - PROCESS | 6658 | __end_cc_report 03:16:52 INFO - PROCESS | 6658 | __startTimestamp1465553812912__endTimestamp 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | ------- Summary: start ------- 03:16:52 INFO - PROCESS | 6658 | Number of tests: 14 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.50 stddev:2.41 (2.1%) stddev-sans-first:2.51 03:16:52 INFO - PROCESS | 6658 | Values: 116.0 108.0 115.0 116.0 115.0 116.0 115.0 116.0 114.0 115.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:159.00 stddev:20.74 (13.0%) stddev-sans-first:21.97 03:16:52 INFO - PROCESS | 6658 | Values: 155.0 136.0 162.0 187.0 145.0 166.0 156.0 137.0 196.0 138.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:3.95 (2.4%) stddev-sans-first:4.08 03:16:52 INFO - PROCESS | 6658 | Values: 163.0 167.0 176.0 165.0 164.0 164.0 164.0 167.0 163.0 163.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:35.67 (46.9%) stddev-sans-first:37.31 03:16:52 INFO - PROCESS | 6658 | Values: 76.0 75.0 76.0 157.0 77.0 76.0 75.0 76.0 164.0 77.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:87.00 stddev:27.82 (32.0%) stddev-sans-first:28.86 03:16:52 INFO - PROCESS | 6658 | Values: 88.0 87.0 139.0 87.0 88.0 88.0 147.0 86.0 87.0 148.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:16:52 INFO - PROCESS | 6658 | Values: 118.0 119.0 117.0 118.0 119.0 118.0 118.0 118.0 119.0 117.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:16:52 INFO - PROCESS | 6658 | Values: 148.0 149.0 148.0 147.0 147.0 149.0 148.0 148.0 147.0 148.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 03:16:52 INFO - PROCESS | 6658 | Values: 95.0 96.0 96.0 95.0 96.0 97.0 96.0 95.0 96.0 96.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.50 stddev:2.02 (3.1%) stddev-sans-first:2.12 03:16:52 INFO - PROCESS | 6658 | Values: 65.0 65.0 64.0 69.0 65.0 65.0 66.0 70.0 64.0 66.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.50 03:16:52 INFO - PROCESS | 6658 | Values: 64.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 67.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:9.22 (10.7%) stddev-sans-first:9.75 03:16:52 INFO - PROCESS | 6658 | Values: 86.0 83.0 83.0 84.0 87.0 86.0 87.0 85.0 114.0 86.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:142.00 stddev:6.92 (4.9%) stddev-sans-first:7.33 03:16:52 INFO - PROCESS | 6658 | Values: 140.0 147.0 143.0 146.0 141.0 132.0 135.0 137.0 155.0 135.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:2.57 (1.5%) stddev-sans-first:2.71 03:16:52 INFO - PROCESS | 6658 | Values: 172.0 173.0 177.0 169.0 173.0 172.0 170.0 171.0 176.0 175.0 03:16:52 INFO - PROCESS | 6658 | 03:16:52 INFO - PROCESS | 6658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.87 03:16:52 INFO - PROCESS | 6658 | Values: 67.0 68.0 68.0 67.0 69.0 73.0 68.0 68.0 67.0 70.0 03:16:52 INFO - PROCESS | 6658 | -------- Summary: end -------- 03:16:52 INFO - PROCESS | 6658 | 03:16:54 INFO - TEST-INFO | 6658: exit 0 03:16:54 INFO - TEST-OK | kraken | took 64929ms 03:16:54 INFO - SUITE-END | took 1181s 03:16:54 INFO - Completed test suite (00:19:41) 03:16:54 INFO - javascript benchmark 03:16:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6227.448095870656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.3178057814675, 2664.054260737438, 2670.279024663341, 2680.463907218554, 2690.529157397455, 4779.450363208228, 4797.184478638631, 4809.01415209882, 4878.341423907771, 4947.653664243504, 4729.1251118543005, 4845.0, 4860.173770459021, 4870.610351171907, 4874.951250487494, 4418.5360537143615, 4453.28747400416, 4544.818207271722, 4565.61192298655, 4577.793999270041, 4258.9148217035645, 4532.977335113336, 4548.113117942003, 4637.28122141067, 4640.9535904641025, 4292.29177185764, 4408.338749187616, 4444.044530425974, 4446.377507149002, 4515.6613254005915, 4407.845725399628, 4469.329600559942, 4532.388127602798, 4536.7504787236685, 4539.455265368144, 4493.078918821667, 4505.842295519641, 4519.0, 4531.13908357411, 4552.840650577247, 4756.0, 4837.7339246341435, 4844.224924012141, 4861.829835955725, 4871.29366241893, 5197.0, 5197.766100525448, 5205.505476979719, 5212.556932660728, 5242.370915490127, 4967.478414766434, 5197.402298735618, 5234.528892399702, 5235.240890070956, 5239.711815850127, 4901.166801643729, 4908.950910490921, 4926.5073492650445, 4933.210686290176, 4983.053219888209, 5408.8377348679605, 5415.458454154632, 5418.756155972991, 5421.864453388697, 5467.152591348347, 4889.926651100236, 5081.3140226069745, 5125.974370128126, 5187.377514698261, 5197.558207552401, 5000.149974504343, 5243.4232234454175, 5270.631055826056, 5270.894582108336, 5297.7880884764945, 5123.231515272739, 5131.974340128276, 5178.663386879841, 5193.844184674465, 5207.3490813648295, 4902.950970490321, 5024.447310795809, 5127.794888204505, 5179.533841954242, 5184.611154163453, 4382.452193475816, 4386.956130438719, 4420.359047938031, 4450.310201918708, 4461.442319710036, 3818.4272359145793, 3834.9808250959127, 3840.558335791364, 3841.0, 3909.9022524436546, 4247.044415006599, 4415.050764085737, 4458.977705111453, 4463.575960283768, 4497.235469970113, 5215.530602245816, 5248.343957005374, 5254.316938798008, 5268.4994925482015, 5300.2049692546425, 4493.0, 4503.234450143484, 4508.909821803545, 4543.295789152687, 4548.999220171557, 4516.458025037016, 4680.368150299666, 4680.391549098664, 4685.554872287127, 4706.552877476634, 4867.488913664156, 4905.3132561441425, 4915.877103072452, 4927.162382394929, 4974.552290293891, 5252.684838909678, 5258.710770907637, 5270.868228294324, 5275.103232450416, 5284.339457567804, 4839.927401088916, 4874.073925954058, 4887.682300650446, 4900.093482705711, 4913.606911447004, 5120.206368012964, 5152.124138896472, 5162.328897243335, 5175.301334319819, 5212.895742085213, 4980.576650984707, 5111.795528178831, 5219.686818790885, 5242.292290540729, 5247.475252474875, 4771.475137734916, 4978.502149784992, 4982.202847544376, 5051.06555287273, 5102.540771330449, 5035.5719763819025, 5050.646454748133, 5052.040112378636, 5056.241563765465, 5061.848144555669, 4720.5043470436485, 4958.42978057528, 4984.40187177541, 5001.549860512571, 5017.397912250407, 4859.0, 5101.285819985131, 5133.743312834418, 5156.4070131935305, 5229.189475631283, 5021.07110184617, 5052.444231134646, 5060.089183946778, 5060.924086138637, 5099.464556221692], "value": 4771.773781722688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2092825866623, 569.4874612848436, 592.8458600763803, 597.2981746447923, 605.1497645807639, 34980.12549686256, 38983.0, 38998.0, 39026.80486597563, 39040.609593904126, 40162.59837401625, 40731.0, 40760.38859417111, 40800.59199408005, 40909.0, 7699.576523291231, 7745.961270193641, 7772.689092436296, 7845.137034926153, 7873.881891771599, 7662.310392064713, 7744.806379840521, 7766.106897706752, 7779.533228006309, 7834.608269586526, 7849.372050235996, 7850.175731548191, 7879.763607091796, 7884.684612615489, 7884.974953256069, 7759.573223472707, 7812.257835505618, 7815.218478152167, 7815.6482958267015, 7819.804504887366, 7766.922330776676, 7796.883046754303, 7854.0, 7855.7250496232355, 7855.882161767521, 36806.07984800375, 37105.25789484222, 37125.0, 37184.0, 37330.066748331235, 2815.81697189682, 3042.6957304269395, 3063.6017317748774, 3116.205367631262, 3355.748318876094, 28872.171449096095, 28904.71095289041, 29147.41705165906, 29176.0, 29399.0, 2895.8986435474867, 2909.3890283040587, 2911.083008852205, 2927.5901373807683, 2973.4499117663086, 259379.0, 259438.0, 261362.0, 261980.0, 262314.68842655857, 31752.523712144335, 52836.471635283924, 52914.0, 53454.0, 53514.197287040726, 31615.73537058538, 33794.0, 33939.32121357559, 33956.66043339535, 33992.150196244795, 12669.366531673379, 12739.745205095845, 12771.10602257833, 12773.0, 12778.0, 10419.791604167875, 10478.790424191626, 10485.266031377883, 10528.36829790215, 10543.947280263703, 7894.447388682852, 7910.881336779953, 7913.44605877583, 7936.6031698414845, 7964.721234756756, 3109.9689003110134, 3153.0, 3188.9681103189137, 3202.327511222623, 3210.197450637341, 851.5614458553849, 881.8280435315052, 897.7710683775596, 915.771057235691, 977.8191034658611, 27417.86291068532, 27846.443071138463, 28402.43195136127, 28537.857310713312, 28783.0, 991.9107280344804, 1004.7287232447344, 1005.7485628592851, 1043.441758659129, 1091.350646365427, 14664.633384165481, 15049.54851354461, 15079.095254284777, 15125.773113403307, 15462.922685386726, 395285.0, 395720.0, 399054.0, 400325.0, 401045.0, 49950.750246248535, 50241.0, 50313.74843125761, 50633.0, 50805.23792143121, 1178.6117491337911, 1211.666791632308, 1228.7419641875306, 1235.4193529041336, 1240.9813852792215, 25858.741412586387, 27777.305567360978, 27936.580951286152, 28016.29959251035, 28415.857920710263, 42919.7854010728, 42931.7853410731, 43243.0, 43243.78378108089, 43337.78331108324, 333311.0, 336097.0, 336355.0, 337337.0, 337446.0, 25104.748952510243, 25287.494250115262, 25312.620310695722, 25509.744902550738, 25668.614970775827, 41380.79309603433, 41615.37576936409, 41985.950351240244, 42188.0, 42917.78541107274, 35983.46024809578, 36251.81874090613, 36458.8177059113, 36579.26841463209, 36692.266154676225, 35312.82343588266, 35453.46819797757, 35737.64262357447, 35796.105097372776, 36628.0, 33035.33929321352, 35478.46782298319, 35836.28327433489, 36005.45991810073, 36230.0, 30965.380692385577, 32101.518477223326, 32258.83870580632, 32276.83861580677, 32473.837630811693, 24881.377965551004, 24891.502169956137, 24927.376815579755, 25453.3636659085, 25509.2491188949], "value": 16416.52149355462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.196847251322, 352.36925902634295, 354.92014296783225, 368.13671939302327, 370.2502432574037, 15750.92124539377, 16540.42108526202, 17667.204975776105, 17720.0, 17735.46793596191, 15810.920945395286, 15960.0, 16737.079460629662, 16843.494695159166, 16908.323667053333, 4943.777530011149, 5164.535191832734, 5184.455632158607, 5214.634975551713, 5220.686758794465, 3115.8286294253808, 5093.567046801027, 5724.398938111501, 6062.484688801457, 6068.059450785136, 6035.366286539916, 6037.909431358533, 6041.395860413945, 6051.697415129248, 6118.755249790025, 5741.368449470555, 5990.430909063632, 6006.789762358297, 6019.518438524951, 6021.548383871227, 4962.206047032493, 5176.275321454999, 5232.555232805216, 5240.3187585614005, 5248.0553500369915, 19653.0, 20020.0, 20212.595748084957, 20279.797202027938, 20474.488137796525, 1857.6934805757035, 1963.1950900130878, 2211.9115235390727, 2278.2026290798253, 2305.4927915858484, 13070.86929130706, 13167.341632918316, 13203.0, 13448.394822233024, 13692.794608080887, 1691.8392752688476, 1732.0819965418348, 1738.2873022060894, 1741.738739189119, 1769.761082253892, 64241.357586424005, 64728.0, 64772.352276477104, 65731.342686573, 66212.0, 8456.746297611082, 8657.39398242117, 8853.64585416589, 8967.730968070968, 9063.456192628464, 11457.484413201426, 11464.54141834334, 11496.94251528737, 11605.129615278718, 11760.764784704257, 6910.44716422685, 6938.653067346713, 7253.1296244451005, 7386.741464048732, 7472.402207823361, 7397.667104980289, 7421.73830448825, 7496.925030749731, 7518.097828260644, 7616.124145723202, 5677.403872593318, 5701.572382071361, 5779.335376431764, 5806.709664516758, 5819.767209311664, 1496.7156240314305, 1573.7403328450907, 1582.6913751818286, 1621.7729517867508, 1652.2317122538077, 828.1759649149014, 862.2670729879552, 882.6381183714775, 901.2834796336797, 932.4079209701753, 16120.838791611934, 16514.58713532147, 16688.0, 16932.746008809878, 17055.573610659834, 836.4186890111314, 892.4199270474244, 907.1427501011481, 922.4188761080476, 941.6186444489992, 9648.469334186546, 9649.997766893428, 9650.179734722487, 9696.95151524238, 9868.950655246677, 370913.0, 373636.0, 373881.0, 375034.0, 387770.0, 52039.479605203465, 63651.0, 63901.0, 64143.67928160329, 65133.0, 875.991240087591, 892.2103938014903, 903.0563061600643, 912.0696889173139, 933.8972713001428, 14913.552593422215, 15018.474353397578, 15139.697206056038, 15258.618534536725, 15268.465603703817, 23040.769592304532, 23060.654090188997, 29635.85182074162, 33619.15952101119, 33813.3237335247, 42362.5763742371, 42437.0, 43955.560444395145, 44311.33532997072, 44652.77673611611, 7233.819154520968, 7355.190928997913, 7364.631768411665, 7371.668274927749, 7655.081390232985, 11847.0, 11924.880751192377, 11986.880131198925, 12105.51577936908, 12175.269483830998, 9957.850632240377, 10211.081002709792, 10374.118199952787, 10501.89498105009, 10567.0, 10228.897711022795, 10442.738931526772, 10513.158947284046, 10530.36817790935, 10642.574297028032, 9543.093406126407, 10168.49157542105, 10196.796064078826, 10202.846957295795, 10484.21368397358, 7073.929260707327, 7108.0759501266575, 7154.499185056996, 7166.498345116001, 7239.819004524929, 9418.576164072496, 9516.19112375456, 9562.091601297865, 9647.469389183661, 9696.17582505495], "value": 8118.544011839641, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.7113106247687, 1405.5713007532704, 1454.893324431246, 1631.7715519827234, 1634.648550561629, 6526.836829079275, 7325.5970921599355, 7504.924950750491, 7960.800979975496, 7972.960135199323, 7642.5796581188015, 7813.570253636062, 7825.256600622932, 7847.1368149503505, 7895.842083158348, 2135.1459416233515, 2183.9890800545977, 2184.1045171479695, 2186.355025267542, 2187.3765976696645, 2130.7869213078725, 2172.8587641803233, 2186.6610675345346, 2189.828441783646, 2191.41927389242, 2166.144372972675, 2168.29530402619, 2182.530755887492, 2184.6941428200066, 2189.4854709143337, 2118.2162599838002, 2118.290372725139, 2127.946801329964, 2131.7761635028255, 2140.357892632212, 2064.762552306489, 2078.1375729072415, 2103.0536258683655, 2107.251925566417, 2113.1124927530473, 7793.908852760618, 7795.961020194919, 7811.453198276123, 7880.0937892142565, 7925.405594580372, 4522.841700540465, 4594.989102397467, 4625.375574297461, 4641.071785642885, 4663.463701674317, 2794.3153927287944, 2840.261532001674, 2889.4510043091955, 2900.0, 2912.810667306618, 854.5897968974926, 857.2670366836328, 903.2142036428284, 911.7811725185908, 914.085914085914, 10317.277790554665, 10392.79214415715, 10404.115650169744, 10419.0, 10431.530581123792, 4064.695147863863, 4173.499180098347, 4232.534421213664, 4261.785391163504, 4275.0, 8985.191332780081, 9032.63869445228, 9056.184943354998, 9071.546422678839, 9095.090490950852, 4350.238708226111, 4407.493138289074, 4445.066536027406, 4560.110778398247, 4566.543345665474, 3392.7794693344854, 3912.4326972589383, 4025.939610905839, 4032.4556184915245, 4042.4744783178, 3557.4841647961416, 3592.8742494012586, 3673.1918977824835, 3702.629737026276, 3714.461403096536, 1122.2088427658482, 1175.1773758369177, 1185.6917201527665, 1202.0804084875078, 1202.5129822421934, 665.4410295351928, 684.6610927590775, 706.0468367703559, 774.7094839435211, 837.2046555772041, 4884.096442158212, 4929.802807887716, 4986.626003049786, 5017.046761115376, 5096.566791822663, 398.6551632837633, 402.822757986485, 410.69403294545754, 414.50466692303013, 418.5939638550601, 3391.4690053817217, 3519.542459480251, 3661.3226553087766, 3718.3307004738867, 3730.5896351401325, 9571.90428095724, 9615.759606009906, 9704.369216000938, 9759.756006099904, 9835.75410614726, 9446.197073248713, 9535.61857525705, 9566.808663826823, 9619.0, 9628.374155679858, 7197.89203161953, 7274.963625181946, 7338.376238019721, 7360.926390736131, 7365.410767138616, 5061.620378471555, 5120.641555091108, 5184.31860609832, 5200.115980283436, 5399.190121481809, 8641.351898607756, 8684.826303473768, 8698.086700896314, 8834.514101724468, 8886.955565222133, 8710.172533609297, 8917.152870477294, 8959.283257339266, 9028.729138125867, 9070.092990700878, 5588.888222235614, 6181.84545386369, 6377.617342959437, 6546.967265163644, 6649.63427011519, 7238.420926325776, 7286.562806231643, 7313.707451702086, 7360.374368178765, 7408.740694075682, 6549.639769812706, 6778.627175505198, 6834.350736680008, 6838.93161068383, 6850.828729281808, 6604.240512341143, 6658.5671931324305, 6696.59820410777, 6705.832354191184, 6745.5952642841585, 6098.207233059674, 6142.938570614416, 6144.723487442986, 6152.600080994721, 6157.261128664589, 4231.407602935653, 4273.166732487135, 4309.6552275818485, 4404.053128577371, 4408.404865343266, 4159.542450330522, 4274.722143060691, 4310.568943105664, 4332.458442694663, 4346.326319420495], "value": 3976.4199378511316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.7774302814719, 286.2500249346712, 289.403828114085, 289.91447522980724, 291.5393677988777, 4931.0, 5051.6716413433105, 5085.4151772546165, 5148.716820574867, 5150.27035671094, 5093.0, 5097.974510127454, 5120.667156634816, 5121.3342265505435, 5131.177852181304, 3956.3076461619103, 3970.960290397088, 3979.5622481527007, 3981.343078392069, 4003.2393845169327, 3927.8428862845453, 4004.7997600120025, 4009.6992725545556, 4038.9394159087637, 4046.2514434829504, 3900.473436086135, 3935.1539419024903, 3940.192260586587, 3948.8617898373564, 3960.9009774755573, 3896.9220615587815, 3900.7854567998747, 3919.647231749142, 3927.4894263745673, 3940.093778430948, 3498.3877821381157, 3505.982470087659, 3511.3855075361967, 3518.9120271993406, 3548.929021419583, 4904.337914381548, 4969.676970996909, 4999.800047988493, 5031.371078615173, 5053.469385714484, 4529.5243999380245, 4550.13547425988, 4553.362529245908, 4567.954320456786, 4571.6114130298965, 5344.251804747339, 5347.732613369316, 5372.435894231088, 5392.272043274147, 5404.243405923174, 3726.273376691546, 3781.2626537825136, 3785.659290663826, 3786.2427514496935, 3804.2962052020466, 5632.662040277596, 5638.605297629168, 5641.492265696107, 5660.801871934504, 5661.131826497287, 3799.411091280856, 3817.408301713239, 3864.884053478344, 3869.8258578364043, 3870.825812838429, 3712.480252764615, 3918.7060970427333, 3921.1961547882615, 3925.9607403926166, 3930.7248492605245, 4450.421445212101, 4469.173202957463, 4475.48531918827, 4475.597196252353, 4508.18852606534, 5364.8122315718765, 5381.78472861089, 5382.6585435335755, 5410.48600382963, 5459.754311056012, 1240.9142000749343, 1280.7000894092503, 1319.2546211390725, 1325.8740419660116, 1339.3838834136407, 847.5677404523738, 850.9531975741394, 860.423516244118, 865.4590880699562, 867.4274978514151, 4106.67146628269, 4148.62662360389, 4160.3343465046055, 4174.666026717855, 4206.789660517024, 4839.395075615548, 4852.4662287148385, 4858.348161625065, 4860.392450943632, 4862.610991120702, 4209.97895010523, 4214.662826973835, 4235.221207093028, 4249.022724773319, 4260.147970405931, 2497.5379554782426, 2637.485690290375, 2656.8405895646324, 2677.7857771378244, 2682.3830518980744, 4669.743164125938, 4674.462436819741, 4674.813007479731, 4682.461516925529, 4689.124350259855, 4928.359313289249, 4953.603711703127, 4960.206366981266, 4979.0, 5049.621278404061, 4245.363195520635, 4561.589456948891, 4579.335996280587, 4601.44782626087, 4602.608778253886, 4821.46963833985, 4855.708657480563, 4872.806162490213, 4907.944791869765, 4912.263160525949, 4711.458182309078, 4722.347178487639, 4730.337752714691, 4841.225403935354, 4903.632227582874, 4375.934360984524, 4520.59314661682, 4562.680612357236, 4574.611158051603, 4594.9310760339295, 3500.544929159193, 3516.2967406518287, 3522.788632682047, 3538.38078336285, 3548.3435564419633, 4797.976010119927, 4831.043427411903, 4836.041403231697, 4941.332920055746, 5194.922076168936, 5243.764030618555, 5335.67985920846, 5336.412994570516, 5344.759485823225, 5380.73096345189, 5303.36359636846, 5315.973420132875, 5359.490848369554, 5369.275147855145, 5435.320584926884, 5178.741062946762, 5248.895022099613, 5267.683938963674, 5289.603279754111, 5306.814261500829, 5388.326459192601, 5394.78420863161, 5406.945930540644, 5409.459054094559, 5409.891802163856, 5216.991458288662, 5244.318238628954, 5262.394969534329, 5267.841964741064, 5270.973645131749], "value": 3854.598715772496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6200990311735, 555.7471350535507, 561.4385614385615, 610.8808782287455, 615.0, 11231.382273974928, 12047.939760301186, 12117.0, 12148.088893332992, 12174.81737773934, 12271.877281227185, 12887.291198984076, 12915.354232288395, 13361.0, 13521.797173042412, 617.6170774120052, 781.0822283816507, 782.7338704840353, 785.4030936488282, 785.9489133206351, 750.3434494817035, 774.7211004038542, 774.8062984253936, 778.2023425988378, 779.3453499060788, 813.7965508622844, 820.5938060659981, 825.8637324841424, 827.1893544326564, 827.4497459189631, 818.3657665309373, 818.423011776696, 820.4502983001404, 820.8317294954579, 822.62159406673, 597.0268462406293, 597.4592993341033, 601.5097695378297, 601.572883252891, 603.1495591216408, 10962.506687199095, 11037.392943388111, 11066.502007409686, 11105.222634415593, 11130.49912753928, 11999.280043197436, 12304.569340073054, 12800.295983720891, 12945.87054129456, 12946.741065178643, 9260.39807412516, 9262.6294948202, 9283.0, 9800.754981125529, 9958.25313101513, 3123.5470856725874, 3154.668759780236, 3176.444122278592, 3179.205198700325, 3219.919502012445, 51594.484055159344, 51867.22199167016, 51892.48107518952, 52801.0, 53521.46478535243, 9151.359404841598, 9166.67916622915, 9198.540072996324, 9210.769730756785, 9217.907820921839, 18149.0, 18358.54103647393, 18386.724199137025, 18487.445376638723, 18603.162857671436, 6255.873942690268, 6417.743290268337, 6647.767328143588, 6730.461563074942, 6809.114815074107, 3304.1078908694517, 3437.6906078453057, 3474.583050034012, 3530.135116896377, 3558.09268636496, 2726.8363898165776, 2825.1242114944434, 2845.4593627210766, 2851.586519954595, 2856.40015596727, 464.0695405711594, 473.6826326361277, 482.22361997184504, 485.53388746802756, 486.8077109541711, 395.3693858296071, 461.50618837843854, 497.86557629440574, 506.5357038010128, 550.2873778456908, 6792.150981127359, 6946.7221311148, 7027.0, 7050.753223637148, 7179.748708795167, 452.39605127155613, 507.91813437378886, 509.959203263738, 515.9037046276662, 535.4404647143745, 3363.9327213455595, 3442.4836274559016, 3453.671901169385, 3539.2213712983103, 3553.6673747344744, 80394.59802701067, 82377.17622823695, 83551.16448835556, 85619.0, 86463.0, 49832.750836245585, 66793.3320666787, 76126.0, 77612.61193694109, 79115.60442197752, 70751.2924870755, 72915.2708472919, 73510.63244683742, 73654.63172684102, 73665.26334736691, 6518.771842985473, 6524.706388212637, 6568.1789776277965, 6704.430123439367, 6797.28628494001, 37293.440598391586, 38452.42321365126, 41590.792046040784, 42549.57450425456, 43640.78179609209, 60059.39940600538, 60101.699491502266, 60623.0, 60646.69676651589, 61282.0, 9914.058164474363, 10105.29882840705, 10428.530716117944, 10483.79032419332, 10893.56425742993, 10192.847107293544, 10360.326578772658, 10622.415767132881, 10658.467076645982, 11158.944205278922, 10273.280870339304, 10318.277720559488, 10331.535080921227, 10404.68785936423, 10743.731406714895, 9912.900870991198, 10109.545070471699, 10157.339772914736, 10187.439690817077, 10213.0, 9572.760680982752, 9703.757406064904, 9717.902820971982, 9953.452560109263, 10020.64927727526, 8828.337874659297, 8999.325050621099, 9201.953990230273, 9404.529773511435, 9667.0, 8731.476111433334, 8835.823283534164, 8842.46945183291, 9048.095190480899, 9078.45529268246], "value": 5982.781689270655, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 115.0, 116.0, 115.0, 116.0, 115.0, 116.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 136.0, 162.0, 187.0, 145.0, 166.0, 156.0, 137.0, 196.0, 138.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 176.0, 165.0, 164.0, 164.0, 164.0, 167.0, 163.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 157.0, 77.0, 76.0, 75.0, 76.0, 164.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 139.0, 87.0, 88.0, 88.0, 147.0, 86.0, 87.0, 148.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 69.0, 65.0, 65.0, 66.0, 70.0, 64.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 84.0, 87.0, 86.0, 87.0, 85.0, 114.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 143.0, 146.0, 141.0, 132.0, 135.0, 137.0, 155.0, 135.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 177.0, 169.0, 173.0, 172.0, 170.0, 171.0, 176.0, 175.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 69.0, 73.0, 68.0, 68.0, 67.0, 70.0], "value": 68.5, "unit": "score"}]}]} 03:16:54 INFO - Return code: 0 03:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:54 ERROR - # TBPL SUCCESS # 03:16:54 INFO - Running post-action listener: _resource_record_post_action 03:16:54 INFO - ##### 03:16:54 INFO - ##### Finished run-tests step (success) 03:16:54 INFO - ##### 03:16:54 INFO - Running post-run listener: _resource_record_post_run 03:16:54 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 534978560; Read time: 16; Write time: 367632 03:16:54 INFO - TinderboxPrint: CPU usage
13.5% 03:16:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:16:54 INFO - TinderboxPrint: I/O write bytes / time
534,978,560 / 367,632 03:16:54 INFO - TinderboxPrint: CPU idle
8,269.0 (86.5%) 03:16:54 INFO - TinderboxPrint: CPU user
1,239.1 (13.0%) 03:16:54 INFO - TinderboxPrint: Swap in / out
0 / 0 03:16:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237977600; Read time: 0; Write time: 216856 03:16:54 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 297000960; Read time: 16; Write time: 150776 03:16:55 INFO - Running post-run listener: _upload_blobber_files 03:16:55 INFO - Blob upload gear active. 03:16:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:55 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 03:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:16:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:59 INFO - (blobuploader) - INFO - Done attempting. 03:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:00 INFO - (blobuploader) - INFO - Done attempting. 03:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:01 INFO - (blobuploader) - INFO - Done attempting. 03:17:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:01 INFO - Return code: 0 03:17:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b47c5235a6a0134719558c41a735c4c54aea338ce3ffad0229e353579bf1b074ea38e5d9d1964adf4085beb9cd108488557a93d7997aee95ae93ca1665f1762", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2eef30a38d33e78fd6f9bf01055eab587ce3c721c6d526a388e14929f8cadcad226363c39c9d3f6c8930d8a0d66ee0cc6fe087ea20d062d22f27c65a029a80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d400381e9a63080c7adbae01184e12b690e077a89f21cabdc3d702ec4bb805a0615c7c4b4b10143eb4cd9010ac9c635291013532da9f7e44061872f62b3b942"} 03:17:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:01 INFO - Contents: 03:17:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b47c5235a6a0134719558c41a735c4c54aea338ce3ffad0229e353579bf1b074ea38e5d9d1964adf4085beb9cd108488557a93d7997aee95ae93ca1665f1762", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2eef30a38d33e78fd6f9bf01055eab587ce3c721c6d526a388e14929f8cadcad226363c39c9d3f6c8930d8a0d66ee0cc6fe087ea20d062d22f27c65a029a80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d400381e9a63080c7adbae01184e12b690e077a89f21cabdc3d702ec4bb805a0615c7c4b4b10143eb4cd9010ac9c635291013532da9f7e44061872f62b3b942"} 03:17:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:01 INFO - Copying logs to upload dir... 03:17:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.886324 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-10 03:17:01.234472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:01.238720) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b47c5235a6a0134719558c41a735c4c54aea338ce3ffad0229e353579bf1b074ea38e5d9d1964adf4085beb9cd108488557a93d7997aee95ae93ca1665f1762", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2eef30a38d33e78fd6f9bf01055eab587ce3c721c6d526a388e14929f8cadcad226363c39c9d3f6c8930d8a0d66ee0cc6fe087ea20d062d22f27c65a029a80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d400381e9a63080c7adbae01184e12b690e077a89f21cabdc3d702ec4bb805a0615c7c4b4b10143eb4cd9010ac9c635291013532da9f7e44061872f62b3b942"} build_url:https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/XjDuF68eTNiBkkMbEz2xgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b47c5235a6a0134719558c41a735c4c54aea338ce3ffad0229e353579bf1b074ea38e5d9d1964adf4085beb9cd108488557a93d7997aee95ae93ca1665f1762", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2eef30a38d33e78fd6f9bf01055eab587ce3c721c6d526a388e14929f8cadcad226363c39c9d3f6c8930d8a0d66ee0cc6fe087ea20d062d22f27c65a029a80dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d400381e9a63080c7adbae01184e12b690e077a89f21cabdc3d702ec4bb805a0615c7c4b4b10143eb4cd9010ac9c635291013532da9f7e44061872f62b3b942"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:01.266681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:01.267064) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465552499.217960-1665672803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:01.316900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:17:01.317221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:17:01.320588) ========= ========= Total master_lag: 0.56 =========