builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1465455064.73 results: success (0) buildid: 20160608173003 builduid: 5409e863a65f46c7a617fd02e75a93b5 revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.728732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.729209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.729511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.794393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.794706) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 23:51:05-- 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% 67.2M=0s 2016-06-08 23:51:05 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129503 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.951466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.951747) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017295 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.000671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.000974) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a447c89176fb240f78db350e8d65f62d0a6fabb --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 8a447c89176fb240f78db350e8d65f62d0a6fabb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 23:51:05,346 truncating revision to first 12 chars 2016-06-08 23:51:05,346 Setting DEBUG logging. 2016-06-08 23:51:05,346 attempt 1/10 2016-06-08 23:51:05,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a447c89176f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 23:51:05,645 unpacking tar archive at: fx-team-8a447c89176f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.697039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.697386) ========= script_repo_revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.697814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.698099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:05.708261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 23:51:05.708561) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:51:06 INFO - MultiFileLogger online at 20160608 23:51:06 in /builds/slave/test 23:51:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:51:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:06 INFO - {'append_to_log': False, 23:51:06 INFO - 'base_work_dir': '/builds/slave/test', 23:51:06 INFO - 'blob_upload_branch': 'Fx-Team', 23:51:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:06 INFO - 'branch': 'Fx-Team', 23:51:06 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:06 INFO - 'config_files': ('talos/linux_config.py',), 23:51:06 INFO - 'default_actions': ('clobber', 23:51:06 INFO - 'read-buildbot-config', 23:51:06 INFO - 'download-and-extract', 23:51:06 INFO - 'populate-webroot', 23:51:06 INFO - 'create-virtualenv', 23:51:06 INFO - 'install', 23:51:06 INFO - 'run-tests'), 23:51:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:06 INFO - 'download_minidump_stackwalk': True, 23:51:06 INFO - 'download_symbols': 'ondemand', 23:51:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:06 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:06 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:06 INFO - 'installer_path': 'installer.exe', 23:51:06 INFO - 'log_level': 'info', 23:51:06 INFO - 'log_name': 'talos', 23:51:06 INFO - 'log_to_console': True, 23:51:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:51:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:51:06 INFO - 'opt_config_files': (), 23:51:06 INFO - 'pip_index': False, 23:51:06 INFO - 'sps_profile': False, 23:51:06 INFO - 'sps_profile_interval': 0, 23:51:06 INFO - 'suite': 'dromaeojs-e10s', 23:51:06 INFO - 'system_bits': '32', 23:51:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:06 INFO - 'title': 'talos-linux64-ix-026', 23:51:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:06 INFO - 'use_talos_json': True, 23:51:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:06 INFO - 'work_dir': 'build'} 23:51:06 INFO - ##### 23:51:06 INFO - ##### Running clobber step. 23:51:06 INFO - ##### 23:51:06 INFO - Running pre-action listener: _resource_record_pre_action 23:51:06 INFO - Running main action method: clobber 23:51:06 INFO - rmtree: /builds/slave/test/build 23:51:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:06 INFO - Running post-action listener: _resource_record_post_action 23:51:06 INFO - ##### 23:51:06 INFO - ##### Finished clobber step (success) 23:51:06 INFO - ##### 23:51:06 INFO - ##### 23:51:06 INFO - ##### Running read-buildbot-config step. 23:51:06 INFO - ##### 23:51:06 INFO - Running pre-action listener: _resource_record_pre_action 23:51:06 INFO - Running main action method: read_buildbot_config 23:51:06 INFO - Using buildbot properties: 23:51:06 INFO - { 23:51:06 INFO - "project": "", 23:51:06 INFO - "product": "firefox", 23:51:06 INFO - "script_repo_revision": "production", 23:51:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:51:06 INFO - "repository": "", 23:51:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:51:06 INFO - "buildid": "20160608173003", 23:51:06 INFO - "pgo_build": "True", 23:51:06 INFO - "basedir": "/builds/slave/test", 23:51:06 INFO - "buildnumber": 547, 23:51:06 INFO - "slavename": "talos-linux64-ix-026", 23:51:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:51:06 INFO - "platform": "ubuntu64_hw", 23:51:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:51:06 INFO - "branch": "fx-team", 23:51:06 INFO - "repo_path": "integration/fx-team", 23:51:06 INFO - "revision": "8a447c89176fb240f78db350e8d65f62d0a6fabb", 23:51:06 INFO - "stage_platform": "linux64-pgo", 23:51:06 INFO - "builduid": "5409e863a65f46c7a617fd02e75a93b5", 23:51:06 INFO - "slavebuilddir": "test" 23:51:06 INFO - } 23:51:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:51:06 INFO - Running post-action listener: _resource_record_post_action 23:51:06 INFO - ##### 23:51:06 INFO - ##### Finished read-buildbot-config step (success) 23:51:06 INFO - ##### 23:51:06 INFO - ##### 23:51:06 INFO - ##### Running download-and-extract step. 23:51:06 INFO - ##### 23:51:06 INFO - Running pre-action listener: _resource_record_pre_action 23:51:06 INFO - Running main action method: download_and_extract 23:51:06 INFO - mkdir: /builds/slave/test/build/tests 23:51:06 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')]} 23:51:06 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:07 INFO - Downloaded 1361 bytes. 23:51:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:07 INFO - Using the following test package requirements: 23:51:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:51:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:51:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'jsshell-linux-x86_64.zip'], 23:51:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:51:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:51:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:51:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:51:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:51:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:07 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:08 INFO - Downloaded 24451190 bytes. 23:51:08 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'] 23:51:08 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 23:51:09 INFO - Return code: 0 23:51:09 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 23:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:09 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:11 INFO - Downloaded 24451190 bytes. 23:51:11 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'] 23:51:11 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 23:51:12 INFO - Return code: 0 23:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:12 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:51:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:13 INFO - Downloaded 10833369 bytes. 23:51:13 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'] 23:51:13 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 23:51:14 INFO - Return code: 0 23:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:14 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:15 INFO - Downloaded 59327656 bytes. 23:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:15 INFO - mkdir: /builds/slave/test/properties 23:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 23:51:15 INFO - Contents: 23:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:16 INFO - Running post-action listener: _resource_record_post_action 23:51:16 INFO - Running post-action listener: set_extra_try_arguments 23:51:16 INFO - ##### 23:51:16 INFO - ##### Finished download-and-extract step (success) 23:51:16 INFO - ##### 23:51:16 INFO - ##### 23:51:16 INFO - ##### Running populate-webroot step. 23:51:16 INFO - ##### 23:51:16 INFO - Running pre-action listener: _resource_record_pre_action 23:51:16 INFO - Running main action method: populate_webroot 23:51:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:51:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:51:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:51:16 INFO - '--tppagecycles', 23:51:16 INFO - '7'], 23:51:16 INFO - 'tests': ['tsvgm']}}, 23:51:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:51:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:51:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:51:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:51:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['damp', 'tps']}, 23:51:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'tests': ['damp', 'tps']}, 23:51:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['dromaeo_dom']}, 23:51:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:51:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'other-e10s': {'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['a11yr', 23:51:16 INFO - 'ts_paint', 23:51:16 INFO - 'tpaint', 23:51:16 INFO - 'sessionrestore', 23:51:16 INFO - 'sessionrestore_no_auto_restore', 23:51:16 INFO - 'tabpaint']}, 23:51:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['tsvgx', 23:51:16 INFO - 'tsvgr_opacity', 23:51:16 INFO - 'tart', 23:51:16 INFO - 'tscrollx', 23:51:16 INFO - 'cart']}, 23:51:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:51:16 INFO - 'tsvgr_opacity', 23:51:16 INFO - 'tart', 23:51:16 INFO - 'tscrollx', 23:51:16 INFO - 'cart']}, 23:51:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'talos_options': ['--disable-e10s'], 23:51:16 INFO - 'tests': ['tp5o']}, 23:51:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'tests': ['tp5o']}, 23:51:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'talos_options': ['--disable-e10s', 23:51:16 INFO - '--xperf_path', 23:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:16 INFO - 'tests': ['tp5n']}, 23:51:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:16 INFO - 'talos_options': ['--xperf_path', 23:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:16 INFO - 'tests': ['tp5n']}}, 23:51:16 INFO - 'talos.zip': {'path': '', 23:51:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:51:16 INFO - Running post-action listener: _resource_record_post_action 23:51:16 INFO - ##### 23:51:16 INFO - ##### Finished populate-webroot step (success) 23:51:16 INFO - ##### 23:51:16 INFO - ##### 23:51:16 INFO - ##### Running create-virtualenv step. 23:51:16 INFO - ##### 23:51:16 INFO - Running pre-action listener: _resource_record_pre_action 23:51:16 INFO - Running main action method: create_virtualenv 23:51:16 INFO - Creating virtualenv /builds/slave/test/build/venv 23:51:16 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 23:51:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:51:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:51:16 INFO - Using real prefix '/usr' 23:51:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 23:51:18 INFO - Installing pip.................done. 23:51:18 INFO - Return code: 0 23:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:18 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:18 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 23:51:18 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 23:51:18 INFO - Using env: {'DISPLAY': ':0', 23:51:18 INFO - 'HOME': '/home/cltbld', 23:51:18 INFO - 'LANG': 'en_US.UTF-8', 23:51:18 INFO - 'LANGUAGE': 'en_US:en', 23:51:18 INFO - 'LOGNAME': 'cltbld', 23:51:18 INFO - 'MAIL': '/var/mail/cltbld', 23:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:18 INFO - 'MOZ_NO_REMOTE': '1', 23:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:18 INFO - 'NO_EM_RESTART': '1', 23:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:18 INFO - 'PWD': '/builds/slave/test', 23:51:18 INFO - 'SHELL': '/bin/bash', 23:51:18 INFO - 'SHLVL': '1', 23:51:18 INFO - 'TERM': 'linux', 23:51:18 INFO - 'TMOUT': '86400', 23:51:18 INFO - 'USER': 'cltbld', 23:51:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:18 INFO - '_': '/tools/buildbot/bin/python'} 23:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:18 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 23:51:18 INFO - Cleaning up... 23:51:18 INFO - Return code: 0 23:51:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:18 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:18 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 23:51:18 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 23:51:18 INFO - Using env: {'DISPLAY': ':0', 23:51:18 INFO - 'HOME': '/home/cltbld', 23:51:18 INFO - 'LANG': 'en_US.UTF-8', 23:51:18 INFO - 'LANGUAGE': 'en_US:en', 23:51:18 INFO - 'LOGNAME': 'cltbld', 23:51:18 INFO - 'MAIL': '/var/mail/cltbld', 23:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:18 INFO - 'MOZ_NO_REMOTE': '1', 23:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:18 INFO - 'NO_EM_RESTART': '1', 23:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:18 INFO - 'PWD': '/builds/slave/test', 23:51:18 INFO - 'SHELL': '/bin/bash', 23:51:18 INFO - 'SHLVL': '1', 23:51:18 INFO - 'TERM': 'linux', 23:51:18 INFO - 'TMOUT': '86400', 23:51:18 INFO - 'USER': 'cltbld', 23:51:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:18 INFO - '_': '/tools/buildbot/bin/python'} 23:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:19 INFO - Downloading/unpacking psutil>=3.1.1 23:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:21 INFO - Installing collected packages: psutil 23:51:21 INFO - Running setup.py install for psutil 23:51:21 INFO - building 'psutil._psutil_linux' extension 23:51:21 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 23:51:21 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 23:51:21 INFO - building 'psutil._psutil_posix' extension 23:51:21 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 23:51:21 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 23:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:21 INFO - Successfully installed psutil 23:51:21 INFO - Cleaning up... 23:51:21 INFO - Return code: 0 23:51:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:21 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:21 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 23:51:21 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 23:51:21 INFO - Using env: {'DISPLAY': ':0', 23:51:21 INFO - 'HOME': '/home/cltbld', 23:51:21 INFO - 'LANG': 'en_US.UTF-8', 23:51:21 INFO - 'LANGUAGE': 'en_US:en', 23:51:21 INFO - 'LOGNAME': 'cltbld', 23:51:21 INFO - 'MAIL': '/var/mail/cltbld', 23:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:21 INFO - 'MOZ_NO_REMOTE': '1', 23:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:21 INFO - 'NO_EM_RESTART': '1', 23:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:21 INFO - 'PWD': '/builds/slave/test', 23:51:21 INFO - 'SHELL': '/bin/bash', 23:51:21 INFO - 'SHLVL': '1', 23:51:21 INFO - 'TERM': 'linux', 23:51:21 INFO - 'TMOUT': '86400', 23:51:21 INFO - 'USER': 'cltbld', 23:51:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:21 INFO - '_': '/tools/buildbot/bin/python'} 23:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:51:23 INFO - Installing collected packages: mozsystemmonitor 23:51:23 INFO - Running setup.py install for mozsystemmonitor 23:51:23 INFO - Successfully installed mozsystemmonitor 23:51:23 INFO - Cleaning up... 23:51:24 INFO - Return code: 0 23:51:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:51: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')]} 23:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51: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')]} 23:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:24 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:24 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 23:51:24 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 23:51:24 INFO - Using env: {'DISPLAY': ':0', 23:51:24 INFO - 'HOME': '/home/cltbld', 23:51:24 INFO - 'LANG': 'en_US.UTF-8', 23:51:24 INFO - 'LANGUAGE': 'en_US:en', 23:51:24 INFO - 'LOGNAME': 'cltbld', 23:51:24 INFO - 'MAIL': '/var/mail/cltbld', 23:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:24 INFO - 'MOZ_NO_REMOTE': '1', 23:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:24 INFO - 'NO_EM_RESTART': '1', 23:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:24 INFO - 'PWD': '/builds/slave/test', 23:51:24 INFO - 'SHELL': '/bin/bash', 23:51:24 INFO - 'SHLVL': '1', 23:51:24 INFO - 'TERM': 'linux', 23:51:24 INFO - 'TMOUT': '86400', 23:51:24 INFO - 'USER': 'cltbld', 23:51:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:24 INFO - '_': '/tools/buildbot/bin/python'} 23:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:24 INFO - Downloading/unpacking jsonschema==2.5.1 23:51:24 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 23:51:24 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 23:51:24 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 23:51:24 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 23:51:24 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 23:51:24 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 23:51:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:51:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 INFO - Downloading functools32-3.2.3-2.tar.gz 23:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:51:26 INFO - warning: no files found matching '*.txt' 23:51:26 INFO - no previously-included directories found matching 'build' 23:51:26 INFO - no previously-included directories found matching 'dist' 23:51:26 INFO - no previously-included directories found matching '.git*' 23:51:26 INFO - Installing collected packages: jsonschema, functools32 23:51:26 INFO - Running setup.py install for functools32 23:51:26 INFO - warning: no files found matching '*.txt' 23:51:26 INFO - no previously-included directories found matching 'build' 23:51:26 INFO - no previously-included directories found matching 'dist' 23:51:26 INFO - no previously-included directories found matching '.git*' 23:51:26 INFO - Successfully installed jsonschema functools32 23:51:26 INFO - Cleaning up... 23:51:26 INFO - Return code: 0 23:51:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:51: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')]} 23:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51: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')]} 23:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:26 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:26 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 23:51:26 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 23:51:26 INFO - Using env: {'DISPLAY': ':0', 23:51:26 INFO - 'HOME': '/home/cltbld', 23:51:26 INFO - 'LANG': 'en_US.UTF-8', 23:51:26 INFO - 'LANGUAGE': 'en_US:en', 23:51:26 INFO - 'LOGNAME': 'cltbld', 23:51:26 INFO - 'MAIL': '/var/mail/cltbld', 23:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:26 INFO - 'MOZ_NO_REMOTE': '1', 23:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:26 INFO - 'NO_EM_RESTART': '1', 23:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:26 INFO - 'PWD': '/builds/slave/test', 23:51:26 INFO - 'SHELL': '/bin/bash', 23:51:26 INFO - 'SHLVL': '1', 23:51:26 INFO - 'TERM': 'linux', 23:51:26 INFO - 'TMOUT': '86400', 23:51:26 INFO - 'USER': 'cltbld', 23:51:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:26 INFO - '_': '/tools/buildbot/bin/python'} 23:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:26 INFO - Downloading/unpacking blobuploader==1.2.4 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:26 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 23:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 23:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:51:28 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 23:51:28 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 23:51:28 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 23:51:28 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 23:51:28 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 23:51:28 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 23:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:51:29 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 23:51:29 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 23:51:29 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 23:51:29 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 23:51:29 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 23:51:29 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 23:51:29 INFO - Downloading docopt-0.6.1.tar.gz 23:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 23:51:29 INFO - Running setup.py install for blobuploader 23:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:51:29 INFO - Running setup.py install for requests 23:51:29 INFO - Running setup.py install for docopt 23:51:29 INFO - Successfully installed blobuploader requests docopt 23:51:29 INFO - Cleaning up... 23:51:30 INFO - Return code: 0 23:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:30 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:30 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 23:51:30 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 23:51:30 INFO - Using env: {'DISPLAY': ':0', 23:51:30 INFO - 'HOME': '/home/cltbld', 23:51:30 INFO - 'LANG': 'en_US.UTF-8', 23:51:30 INFO - 'LANGUAGE': 'en_US:en', 23:51:30 INFO - 'LOGNAME': 'cltbld', 23:51:30 INFO - 'MAIL': '/var/mail/cltbld', 23:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:30 INFO - 'MOZ_NO_REMOTE': '1', 23:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:30 INFO - 'NO_EM_RESTART': '1', 23:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:30 INFO - 'PWD': '/builds/slave/test', 23:51:30 INFO - 'SHELL': '/bin/bash', 23:51:30 INFO - 'SHLVL': '1', 23:51:30 INFO - 'TERM': 'linux', 23:51:30 INFO - 'TMOUT': '86400', 23:51:30 INFO - 'USER': 'cltbld', 23:51:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:30 INFO - '_': '/tools/buildbot/bin/python'} 23:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:30 INFO - Running setup.py (path:/tmp/pip-IAbpmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:30 INFO - Running setup.py (path:/tmp/pip-VqhLov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:51:30 INFO - Running setup.py (path:/tmp/pip-NR5oSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:51:30 INFO - Running setup.py (path:/tmp/pip-3pQpAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:51:30 INFO - Running setup.py (path:/tmp/pip-nImMfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:51:30 INFO - Running setup.py (path:/tmp/pip-jMPUhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:51:30 INFO - Running setup.py (path:/tmp/pip-HvceVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:51:30 INFO - Running setup.py (path:/tmp/pip-RCTUZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:51:30 INFO - Running setup.py (path:/tmp/pip-27ZKyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:51:30 INFO - Running setup.py (path:/tmp/pip-HKuGDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:51:30 INFO - Running setup.py (path:/tmp/pip-IaNQ3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:51:31 INFO - Running setup.py (path:/tmp/pip-HjbhE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:51:31 INFO - Running setup.py (path:/tmp/pip-OI3P7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:51:31 INFO - Running setup.py (path:/tmp/pip-bLy2K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:31 INFO - Running setup.py (path:/tmp/pip-dwTvAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:51:31 INFO - Running setup.py (path:/tmp/pip-8d0YAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:51:31 INFO - Running setup.py (path:/tmp/pip-i9pTR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:51:31 INFO - Running setup.py install for manifestparser 23:51:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:51:31 INFO - Running setup.py install for mozcrash 23:51:31 INFO - Running setup.py install for mozdebug 23:51:31 INFO - Running setup.py install for mozdevice 23:51:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:51:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:51:31 INFO - Running setup.py install for mozfile 23:51:31 INFO - Running setup.py install for mozhttpd 23:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozinfo 23:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozInstall 23:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozleak 23:51:32 INFO - Running setup.py install for mozlog 23:51:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for moznetwork 23:51:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozprocess 23:51:32 INFO - Running setup.py install for mozprofile 23:51:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozrunner 23:51:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:51:32 INFO - Running setup.py install for mozscreenshot 23:51:33 INFO - Running setup.py install for moztest 23:51:33 INFO - Running setup.py install for mozversion 23:51:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:51:33 INFO - Cleaning up... 23:51:33 INFO - Return code: 0 23:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51: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')]} 23:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51: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')]} 23:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:33 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:33 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 23:51:33 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 23:51:33 INFO - Using env: {'DISPLAY': ':0', 23:51:33 INFO - 'HOME': '/home/cltbld', 23:51:33 INFO - 'LANG': 'en_US.UTF-8', 23:51:33 INFO - 'LANGUAGE': 'en_US:en', 23:51:33 INFO - 'LOGNAME': 'cltbld', 23:51:33 INFO - 'MAIL': '/var/mail/cltbld', 23:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:33 INFO - 'MOZ_NO_REMOTE': '1', 23:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:33 INFO - 'NO_EM_RESTART': '1', 23:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:33 INFO - 'PWD': '/builds/slave/test', 23:51:33 INFO - 'SHELL': '/bin/bash', 23:51:33 INFO - 'SHLVL': '1', 23:51:33 INFO - 'TERM': 'linux', 23:51:33 INFO - 'TMOUT': '86400', 23:51:33 INFO - 'USER': 'cltbld', 23:51:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:33 INFO - '_': '/tools/buildbot/bin/python'} 23:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:33 INFO - Running setup.py (path:/tmp/pip-oVlooJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:33 INFO - Running setup.py (path:/tmp/pip-c5uhCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:51:33 INFO - Running setup.py (path:/tmp/pip-KEMN5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:51:33 INFO - Running setup.py (path:/tmp/pip-PIL70C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:51:33 INFO - Running setup.py (path:/tmp/pip-ffNRtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:51:33 INFO - Running setup.py (path:/tmp/pip-H75A0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:51:33 INFO - Running setup.py (path:/tmp/pip-JL4rrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:51:33 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)) 23:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:51:33 INFO - Running setup.py (path:/tmp/pip-FCQ6cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:51:34 INFO - Running setup.py (path:/tmp/pip-6Mcqw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:51:34 INFO - Running setup.py (path:/tmp/pip-PrEREu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:51:34 INFO - Running setup.py (path:/tmp/pip-iENxW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:51:34 INFO - Running setup.py (path:/tmp/pip-9uqsyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:51:34 INFO - Running setup.py (path:/tmp/pip-oIKUy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:51:34 INFO - Running setup.py (path:/tmp/pip-bI2NY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:34 INFO - Running setup.py (path:/tmp/pip-OoKHUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:51:34 INFO - Running setup.py (path:/tmp/pip-tDMn9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:51:34 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)) 23:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:51:34 INFO - Running setup.py (path:/tmp/pip-zHljZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:51:34 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)) 23:51:34 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)) 23:51:34 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)) 23:51:34 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)) 23:51:34 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)) 23:51:34 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)) 23:51:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51:36 INFO - Downloading blessings-1.6.tar.gz 23:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:51:36 INFO - Installing collected packages: blessings 23:51:36 INFO - Running setup.py install for blessings 23:51:36 INFO - Successfully installed blessings 23:51:36 INFO - Cleaning up... 23:51:36 INFO - Return code: 0 23:51:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:51:37 INFO - Reading from file tmpfile_stdout 23:51:37 INFO - Current package versions: 23:51:37 INFO - argparse == 1.2.1 23:51:37 INFO - blessings == 1.6 23:51:37 INFO - blobuploader == 1.2.4 23:51:37 INFO - docopt == 0.6.1 23:51:37 INFO - functools32 == 3.2.3-2 23:51:37 INFO - jsonschema == 2.5.1 23:51:37 INFO - manifestparser == 1.1 23:51:37 INFO - mozInstall == 1.12 23:51:37 INFO - mozcrash == 0.17 23:51:37 INFO - mozdebug == 0.1 23:51:37 INFO - mozdevice == 0.48 23:51:37 INFO - mozfile == 1.2 23:51:37 INFO - mozhttpd == 0.7 23:51:37 INFO - mozinfo == 0.9 23:51:37 INFO - mozleak == 0.1 23:51:37 INFO - mozlog == 3.2 23:51:37 INFO - moznetwork == 0.27 23:51:37 INFO - mozprocess == 0.22 23:51:37 INFO - mozprofile == 0.28 23:51:37 INFO - mozrunner == 6.11 23:51:37 INFO - mozscreenshot == 0.1 23:51:37 INFO - mozsystemmonitor == 0.3 23:51:37 INFO - moztest == 0.7 23:51:37 INFO - mozversion == 1.4 23:51:37 INFO - psutil == 3.1.1 23:51:37 INFO - requests == 1.2.3 23:51:37 INFO - wsgiref == 0.1.2 23:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:37 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 23:51:37 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 23:51:37 INFO - Using env: {'DISPLAY': ':0', 23:51:37 INFO - 'HOME': '/home/cltbld', 23:51:37 INFO - 'LANG': 'en_US.UTF-8', 23:51:37 INFO - 'LANGUAGE': 'en_US:en', 23:51:37 INFO - 'LOGNAME': 'cltbld', 23:51:37 INFO - 'MAIL': '/var/mail/cltbld', 23:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:37 INFO - 'MOZ_NO_REMOTE': '1', 23:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:37 INFO - 'NO_EM_RESTART': '1', 23:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:37 INFO - 'PWD': '/builds/slave/test', 23:51:37 INFO - 'SHELL': '/bin/bash', 23:51:37 INFO - 'SHLVL': '1', 23:51:37 INFO - 'TERM': 'linux', 23:51:37 INFO - 'TMOUT': '86400', 23:51:37 INFO - 'USER': 'cltbld', 23:51:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:37 INFO - '_': '/tools/buildbot/bin/python'} 23:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 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)) 23:51:37 INFO - Cleaning up... 23:51:37 INFO - Return code: 0 23:51:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:37 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 23:51:37 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 23:51:37 INFO - Using env: {'DISPLAY': ':0', 23:51:37 INFO - 'HOME': '/home/cltbld', 23:51:37 INFO - 'LANG': 'en_US.UTF-8', 23:51:37 INFO - 'LANGUAGE': 'en_US:en', 23:51:37 INFO - 'LOGNAME': 'cltbld', 23:51:37 INFO - 'MAIL': '/var/mail/cltbld', 23:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:37 INFO - 'MOZ_NO_REMOTE': '1', 23:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:37 INFO - 'NO_EM_RESTART': '1', 23:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:37 INFO - 'PWD': '/builds/slave/test', 23:51:37 INFO - 'SHELL': '/bin/bash', 23:51:37 INFO - 'SHLVL': '1', 23:51:37 INFO - 'TERM': 'linux', 23:51:37 INFO - 'TMOUT': '86400', 23:51:37 INFO - 'USER': 'cltbld', 23:51:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:37 INFO - '_': '/tools/buildbot/bin/python'} 23:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:51:37 INFO - Cleaning up... 23:51:37 INFO - Return code: 0 23:51:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 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 0x7f15dc1bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', '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 23:51:37 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 23:51:37 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 23:51:37 INFO - Using env: {'DISPLAY': ':0', 23:51:37 INFO - 'HOME': '/home/cltbld', 23:51:37 INFO - 'LANG': 'en_US.UTF-8', 23:51:37 INFO - 'LANGUAGE': 'en_US:en', 23:51:37 INFO - 'LOGNAME': 'cltbld', 23:51:37 INFO - 'MAIL': '/var/mail/cltbld', 23:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:37 INFO - 'MOZ_NO_REMOTE': '1', 23:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:37 INFO - 'NO_EM_RESTART': '1', 23:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:37 INFO - 'PWD': '/builds/slave/test', 23:51:37 INFO - 'SHELL': '/bin/bash', 23:51:37 INFO - 'SHLVL': '1', 23:51:37 INFO - 'TERM': 'linux', 23:51:37 INFO - 'TMOUT': '86400', 23:51:37 INFO - 'USER': 'cltbld', 23:51:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:37 INFO - '_': '/tools/buildbot/bin/python'} 23:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:37 INFO - Downloading/unpacking flake8 23:51:37 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 23:51:37 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 23:51:37 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 23:51:37 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 23:51:37 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 23:51:37 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 23:51:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:51:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:51:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:51:40 INFO - no previously-included directories found matching 'docs/_build' 23:51:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:51:40 INFO - Running setup.py install for pep8 23:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:51:40 INFO - no previously-included directories found matching 'docs/_build' 23:51:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:51:40 INFO - Cleaning up... 23:51:40 INFO - Return code: 0 23:51:40 INFO - Running post-action listener: _resource_record_post_action 23:51:40 INFO - Running post-action listener: _start_resource_monitoring 23:51:40 INFO - Starting resource monitoring. 23:51:40 INFO - ##### 23:51:40 INFO - ##### Finished create-virtualenv step (success) 23:51:40 INFO - ##### 23:51:40 INFO - ##### 23:51:40 INFO - ##### Running install step. 23:51:40 INFO - ##### 23:51:40 INFO - Running pre-action listener: _resource_record_pre_action 23:51:40 INFO - Running main action method: install 23:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:51:40 INFO - Reading from file tmpfile_stdout 23:51:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:51:40 INFO - Reading from file tmpfile_stdout 23:51:40 INFO - Output received: 23:51:40 INFO - Usage: mozinstall [options] installer 23:51:40 INFO - Options: 23:51:40 INFO - -h, --help show this help message and exit 23:51:40 INFO - -d DEST, --destination=DEST 23:51:40 INFO - Directory to install application into. [default: 23:51:40 INFO - "/builds/slave/test"] 23:51:40 INFO - --app=APP Application being installed. [default: firefox] 23:51:40 INFO - mkdir: /builds/slave/test/build/application 23:51:40 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'] 23:51:40 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 23:51:57 INFO - Reading from file tmpfile_stdout 23:51:57 INFO - Output received: 23:51:57 INFO - /builds/slave/test/build/application/firefox/firefox 23:51:57 INFO - Running post-action listener: _resource_record_post_action 23:51:57 INFO - ##### 23:51:57 INFO - ##### Finished install step (success) 23:51:57 INFO - ##### 23:51:57 INFO - ##### 23:51:57 INFO - ##### Running run-tests step. 23:51:57 INFO - ##### 23:51:57 INFO - Running pre-action listener: _resource_record_pre_action 23:51:57 INFO - Running main action method: run_tests 23:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:51:57 INFO - Python 2.7.3 23:51:57 INFO - Return code: 0 23:51:57 INFO - grabbing minidump binary from tooltool 23:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:57 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 0x253c110>, '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 0x24a8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a86c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:51:57 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 23:51:57 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 23:51:57 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 23:51:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:51:57 INFO - Return code: 0 23:51:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:51:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:51:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:51:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:51:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:51:58 INFO - Return code: 0 23:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:51:58 INFO - Using env: {'DISPLAY': ':0', 23:51:58 INFO - 'HOME': '/home/cltbld', 23:51:58 INFO - 'LANG': 'en_US.UTF-8', 23:51:58 INFO - 'LANGUAGE': 'en_US:en', 23:51:58 INFO - 'LOGNAME': 'cltbld', 23:51:58 INFO - 'MAIL': '/var/mail/cltbld', 23:51:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:51:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:58 INFO - 'MOZ_NO_REMOTE': '1', 23:51:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:58 INFO - 'NO_EM_RESTART': '1', 23:51:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:58 INFO - 'PWD': '/builds/slave/test', 23:51:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:51:58 INFO - 'SHELL': '/bin/bash', 23:51:58 INFO - 'SHLVL': '1', 23:51:58 INFO - 'TERM': 'linux', 23:51:58 INFO - 'TMOUT': '86400', 23:51:58 INFO - 'USER': 'cltbld', 23:51:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674', 23:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:58 INFO - '_': '/tools/buildbot/bin/python'} 23:51:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:51:58 INFO - mozversion application_buildid: 20160608173003 23:51:58 INFO - mozversion application_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:51:58 INFO - mozversion application_display_name: Nightly 23:51:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:51:58 INFO - mozversion application_name: Firefox 23:51:58 INFO - mozversion application_remotingname: firefox 23:51:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:51:58 INFO - mozversion application_vendor: Mozilla 23:51:58 INFO - mozversion application_version: 50.0a1 23:51:58 INFO - mozversion platform_buildid: 20160608173003 23:51:58 INFO - mozversion platform_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:51:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:51:58 INFO - mozversion platform_version: 50.0a1 23:51:58 INFO - using testdate: 1465455118 23:51:58 INFO - actual date: 1465455118 23:51:58 INFO - starting webserver on 'localhost:33115' 23:51:58 INFO - SUITE-START | Running 2 tests 23:51:58 INFO - TEST-START | dromaeo_css 23:51:58 INFO - operating with platform_type : linux_ 23:51:58 INFO - Initialising browser for dromaeo_css test... 23:51:58 INFO - TEST-INFO | started process 19253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Z0MDD/profile http://localhost:33115/getInfo.html) 23:52:03 INFO - PROCESS | 19253 | __metrics Screen width/height:1600/1200 23:52:03 INFO - PROCESS | 19253 | colorDepth:24 23:52:03 INFO - PROCESS | 19253 | Browser inner width/height: 1024/697 23:52:03 INFO - PROCESS | 19253 | __metrics 23:52:03 ERROR - PROCESS | 19253 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:52:04 INFO - TEST-INFO | 19253: exit 0 23:52:04 INFO - Browser initialized. 23:52:04 INFO - Running cycle 1/1 for dromaeo_css test... 23:52:04 INFO - TEST-INFO | started process 19376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Z0MDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:16 INFO - PROCESS | 19376 | RSS: Main: 167301120 23:52:16 INFO - PROCESS | 19376 | 23:53:06 INFO - PROCESS | 19376 | 1465455186159 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] 23:55:14 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33115/tests/dromaeo/cssquery-ext.html) 23:55:15 INFO - PROCESS | 19376 | RSS: Main: 170819584 23:55:15 INFO - PROCESS | 19376 | 23:58:17 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-ext.html (next: http://localhost:33115/tests/dromaeo/cssquery-jquery.html) 23:58:17 INFO - PROCESS | 19376 | RSS: Main: 169824256 23:58:17 INFO - PROCESS | 19376 | 00:01:19 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33115/tests/dromaeo/cssquery-mootools.html) 00:01:20 INFO - PROCESS | 19376 | RSS: Main: 168402944 00:01:20 INFO - PROCESS | 19376 | 00:04:22 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33115/tests/dromaeo/cssquery-prototype.html) 00:04:22 INFO - PROCESS | 19376 | RSS: Main: 170893312 00:04:22 INFO - PROCESS | 19376 | 00:07:25 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33115/tests/dromaeo/cssquery-yui.html) 00:07:25 INFO - PROCESS | 19376 | RSS: Main: 169172992 00:07:25 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | Cycle 1(1): loaded http://localhost:33115/tests/dromaeo/cssquery-yui.html (next: http://localhost:33115/tests/dromaeo/cssquery-dojo.html) 00:10:28 INFO - PROCESS | 19376 | RSS: Main: 171294720 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | __start_tp_report 00:10:28 INFO - PROCESS | 19376 | _x_x_mozilla_page_load 00:10:28 INFO - PROCESS | 19376 | _x_x_mozilla_page_load_details 00:10:28 INFO - PROCESS | 19376 | |i|pagename|runs| 00:10:28 INFO - PROCESS | 19376 | |0;dojo.html;3134.5768321276623;3170.2708377073286;3174.3492584020278;3206.134343727194;3217.4047801156803;5363.9463605363935;5365.6512326698785;5376.8118115865955;5454.754536045877;5469.124940009599;5298.92051619226;5344.385395679498;5357.544608708265;5372.0330340538685;5413.106837371839;4861.513848615145;4877;4902.754862256891;5012.849614511552;5110.770015349318;4931.482194369593;5072.26452164436;5107.69353838769;5112.872178195537;5117.437081920985;4885.413750349963;4908.239222920453;4976.576990955773;4984.152694042022;5004.799808007675;4966.726830024347;4988.426330971948;4991.101601711691;4998.425181104183;5049.040682270357;4969.130402179604;4970.502949705036;4985.1774457214515;4990.101781679296;5023.2214006828635;5124.615653825978;5243.187305967581;5262.815801446931;5319.441458646825;5331.973340133313;5734.799282025151;5741.856453588652;5745.396733342981;5748.913766293509;5768.336641286264;5667.121596152603;5800.361960184377;5801.796937107181;5808.12878068289;5829.4753472187285;5318.787248510055;5372.946270537283;5393.649412788156;5429.294191755086;5433.429489903543;5919.526437884959;5943.881122377528;5944.138099975479;5951.880962380728;5960.552958528127;5546.833594992157;5711.228984087178;5713.057345538023;5725.227094342211;5729.799457018984;5783.334916484658;5801.361850196559;5802.158686990363;5848.824535263949;5850.824475265749;5612.550995920398;5675.3757086720425;5717.914231286534;5737.655740655574;5787.074068149076;5733.512651424676;5741.942580574224;5796.246487956539;5800.187973683687;5836.212111364996;4312.7627980461375;4325.286327755948;4384.254676704968;4415;4423.889402764892;3950.7827069511454;3951.5258169019903;3957.861474848424;3992.4210989406374;3995.1210733638554;5413.079776438015;5529.060059789846;5543.750531226105;5550.084236101079;5568.415316391802;5779.3642699303045;5826.504747096459;5827.475527202572;5887.528997680175;5899.911501327483;5522.723863806794;5549.861253468614;5565.916511252334;5566.972165139229;5601.327840659147;4910.116179087799;4970.378702662168;5044.066847633199;5059.519345662156;5103.387593488805;5980.671063091485;6033.18551995475;6069;6080.087986802015;6102.328743838174;5836.416358364129;5854.326752423355;5873.823785286449;5880.0591905295805;5886.911696324644;5709.54323654115;5941.762329506944;5978.701064946648;6029.216201893902;6043.36544662804;5716;5718.399568045295;5724.914126288026;5744.138379243147;5776.740046697824;5821.79623713185;5848.736806843617;5852.122181672783;5873.676947767914;5904.911426328695;5438.102713052302;5488.56091512686;5567.721613919369;5610.775568977195;5638.689872057076;5494.340679118372;5535.916961245504;5552.7223638818705;5587.720613969204;5687.146927960839;5493.2858728366655;5521.254630624814;5522.972385138049;5524.4199359068325;5563.805266815642;5467.125259958547;5624.3250809903075;5627.549796016391;5634.154876768517;5651.858703532444;5556.833295001156;5561.888762224814;5586.497215250484;5591.440855914376;5654.038813401814 00:10:28 INFO - PROCESS | 19376 | |1;ext.html;562.6792728144957;612.8559788449713;627.5293529852612;631.1574048645059;634.3181080338637;40413;44964;45080.77459612701;45140.3228951566;45337.773311133395;45019.324710129375;45345.77327113368;45450.54549454505;45513.772431137884;45628.543714562846;8799.69201077964;8904.376693631448;8921.241694455979;8933.687320943769;9001.279897608176;8747.081556436578;8814.471131732085;8842.557872106401;8845.823083538326;8858.626912828522;8849.646014159458;8901.510416927067;8914.108589141098;8923.509206993613;8927.866082008775;8809.691660791841;8842.955785221066;8889.066648001932;8891.11088891109;8920.152585504367;8833.779155521099;8850.159234872677;8892.244159246471;8900.065493123193;8933.553322333857;34026.82986585076;41780.79109604463;41989.1602167958;42255.366169507484;42430.57569424328;3271.4275001874576;3283.0807373935336;3461.152017755641;3511.806850623215;3757.1734218471893;31500.527492087636;31564.210894727585;32226.35547289041;32856.34287314241;32859.17852053694;4119.155573107506;4191.11986482839;4211.368294755781;4259.084296876155;4399;289652;293722.99999999785;294476;295202;295361;34673.653263467546;36120.458193127124;36242.63757362445;36353.272934541164;36442.27115457676;37516.249675006344;37536.43695344572;37560.248795023945;37578.248435031695;37673.62326376756;14880.404783808526;14881.181535015678;14890.627734306512;14903.180325082008;14919.179445130405;13481.797773033413;13523.932380338036;13552.254625995467;13568.93215533916;13590.524331648345;8336.083030866599;8451.492910425393;8479.872801907977;8541.060483346826;8547.786305342415;3237.336346049054;3252.454564966726;3257.088015355704;3297.5383446317533;3311.56599899074;1036.2176556699644;1044.848894947914;1084.3397465231478;1202.2786328203008;1227.2084505493906;32805.507917381256;33309.83345083259;33535.16162095918;33707.66292337045;33843.4923476148;1120.8598925134359;1164.1559869095008;1167.4512978899904;1182.2906256246183;1186.9643910682694;16916.661666766595;17283.308667653153;17400.21699023547;17450.825491745174;17524.91237543804;544205;552935;555471;557157;559669;60134.09798853021;60424.39575604276;60928;61100.388996110356;61155;1367.09771550776;1404.6137312239216;1416.2706206303762;1419.9432022719182;1435.7846323051626;31064.68935310618;31549.369012620078;31988.68011319857;32213;32824.343513129126;52552;53512.19731704106;53633;53764.19353709776;53849.19226211531;496830;508184;510713.3571985693;511932;512833;28581.714182858737;28781;28839.42321153523;28866.855665721538;28963.565546516398;48753;49853.75073124611;49932;50164.49835501598;51074.74462627663;41636.58363416327;42241.57758422376;42710.78644606757;42981.1403771929;43066;40773;41446.1710765789;41525.37711934263;41968.79015604902;42235.36646950237;35081;41743;41990.16019679528;42303.576964229964;42432.575674242864;36195.457068144526;37585;37812;38051.61948380592;38287.80856095702;28259.858700706365;28604.284892877844;28646.140615781558;28855.711442885302;28894.566581501716 00:10:28 INFO - PROCESS | 19376 | |2;jquery.html;366.3826452427659;375.1521561271526;376.49361608636383;379.5521284883839;386.63463027439064;17860.464186074423;18836.717449238273;18949.242030318786;19839.900800495976;19956.800431995656;11910.95027690585;12057.939710301458;12320;12333.260004399719;12333.876661233408;5050.3434553508;5262.394824595163;5265.9473405266035;5266.289050978126;5269;3824.273388056274;5480.862978425552;5742.6841523716175;5742.7415766290615;5769.6826674533095;5786.623869448494;5788.392218817026;5797.942020579803;5807.186993820868;5984.461398474136;6157.6305421674615;6296.212973378328;6310.053491976218;6318.147050148263;6323.051542268673;5425;5551.278333816618;5567.582431317667;5613.859653508695;5659.801906933279;13190.47238110484;13727.794083088762;13759.10565813219;13853.792193117111;13914.51299204523;2125.787421257877;2219.6892435059103;2309.3533810533077;2325.813934885205;2444.303373538533;10161.949190254076;10220.948895255551;10385.324953877975;10504;14317.642058948506;1717.7681013063202;1878.8496920246348;1974.6939224420237;1996.5308152584132;2003.1086166655843;57558.424415755726;82421.58789206075;83421;84302.15697843004;84461.15538844594;10591.788164236827;10850.186236032328;11047.558097676163;11059.336439813476;11204.327740335606;15515.146666933202;15628.531144065697;15719.607009824846;15783.36866525349;15810.130442825755;8113.918860811435;8268.2558569729;8280.58597070144;8336.333093352638;8347.707830225912;7456.3662088721985;7585.241475852481;7791.883121753178;7883.487573307832;8047.155048719917;4581.885452863638;4762.119007983534;4766.833160839354;4812.06164797861;4913;1807.737627651228;1849.3540748733637;1950.9219631214592;1971.7338159348305;2003.2187446895723;951.219999600335;977.8924318324979;997.6009596161593;1013.9695809125737;1101.5593762495066;16623.735004938488;18865.434036978913;19136.234550618097;19271;19282;1040.147079394904;1047.3768107975743;1050.417018554694;1053.72603123187;1091.4870011094772;10487.852361389183;10833.767458013848;10843.481108762313;10853.79907804803;10890.990343947056;465776;471402;484170;485949;490498;81188;90250;91405.54297228472;93463.53268233615;94113;991.2169386184977;1016.7763092119721;1032.6230925712212;1056.2606175677056;1068.5084860963889;16708.49874503767;16856.15719214059;16927.915360423118;17137.485875423758;17545.649087018443;41313.79343103385;41782.79108604437;41796;42116.78941605272;42507.7874610625;55293;56050;56596.15105773335;57566.424335756106;58060.709696451246;8084;8261.917380826115;8410.612893077167;8478.74563763088;8781.824363512822;9441.669541566012;10508.264421490423;12897.871021290042;13340.86659133435;13537.526186583422;11167.162462815484;11486.50675412191;11592;11669.533218671158;11917.761644766882;11442.256253343507;11685.415729213675;11730.354830484064;11854.110941679237;11859.347735874264;5505.394406615189;11299.830502542303;11600.709982250512;11736.76526469483;12049.096317776026;11602.18784685064;12441.502339906303;12475.75048499043;12514.623391427118;12819.102662813513;12281.44733487013;12337.198082124632;12386.504539818307;12540.686482838002;12720.554780583005 00:10:28 INFO - PROCESS | 19376 | |3;mootools.html;1440.82710074791;1484.3913995261944;1579.3603590545827;1798.1009495252374;1808.846248068914;7879.645415956282;8499.362547808909;8530.957345213274;9197.494137822425;9224.677136300223;8495.36284778641;8610.138986101387;8672.30621550276;8724.258438032775;8742.737717868458;2268.8298377621663;2283.2465286455513;2286.1541229744935;2287.5196208796174;2293.415179129328;2242.876641784709;2259.89830457629;2261.2876943762744;2273.3748219239674;2291.862488250702;2164.6428339323993;2167.6206663833846;2173.9239126630573;2175.0321107107343;2223.55528894221;2136.6688163334707;2146.37755051035;2148.4199266198193;2153.5585205033008;2162.426956856434;2238.1383167480476;2243.4054975431523;2248.347979086063;2262.072550254404;2280.8403411761183;8689.6524139035;8731.563421828947;8758.255548278405;8766.167214114712;8779.03430622631;5179.067767801795;5320.893582128375;5322.494363035506;5324.973375133139;5330.786768529293;3280.3439312137666;3336.8331583420972;3494.5806503219524;3494.72042236623;3500.1074725944977;1141.132739118276;1148.7650775416378;1157.4964890272759;1166.1894982986828;1170.5902933973127;12645.873541264562;12787.936060319731;12797.360131993457;12848.100632955604;12870.67823304425;4526.117407105583;4568.177728008924;4613.815447382067;4654.720716756938;4674.182018146811;10593.31143475687;10656.520456579472;10669.679909602724;10673.30623509485;10679.09227715653;5243.790248390098;5289.523942845162;5294.92057619136;5297.947020529746;5308.946910530923;4112.527059388149;4725.432948046257;4846.151923413388;4872.829450969199;4919.237518184687;3967.5238971323047;3985.143194213258;4029.738067025634;4086.9182616347507;4149.2738770715005;1214.3685283652628;1246.3207551884245;1251.161721646499;1257.3964497041472;1262.835831341938;1012.3015119567475;1026.6047571684956;1043.1915265669168;1056.2289528644133;1058.9682309530726;6009.609375390585;6141.662208578482;6270.2475702915945;6415.582987105823;6520.152380190545;454.2051410032443;456.4363011680572;470.8257944560535;471.90797794430443;493.97777100030584;4431.135928493977;4553.704009239389;4572.771361431982;4592.3570700101345;4660.906781864343;10969.067629251444;11062.778744425066;11074.944625276983;11135.164862635334;11166.441677916235;10320.741981450525;10664;11046.061084807881;11150.60972865962;11161.386123763272;8208.302294305051;8370.916290837014;8377.287930525974;8401.033881103507;8473.533955632376;6066.272047354346;6343.873122537616;6351.745930162741;6365.90451143224;6409.3270206629495;10135.49322533885;10217.438040907822;10274.383536987805;10357.792844142925;10394.844077338696;10031;10180.440075795903;10426.947865260625;10453.163746900382;10469;7261.709531618676;7512.962435187789;7745.806354841174;7988.880166797619;8241.629126689433;8975.506347150707;8988.775280618036;9002.774930626787;9010.324225682969;9052.411593246681;7919.445638805229;8063.435559510778;8113.716019939274;8133.633986470505;8134.267915887599;7691.346235570039;7733.110692270236;7801.336886364723;7865.685372585032;7898.486598371088;6579.835504112435;7228.855422891407;7254.274572542704;7301.817454563678;7302.488825782144;5300.867478313073;5312.203169524602;5388.191771234347;5423;5475.397706252389;5239.345081864767;5265.763040663256;5273.5781137509675;5285.603579731459;5340.0921843287515 00:10:28 INFO - PROCESS | 19376 | |4;prototype.html;330.11529102006614;331.3009549849817;332.8119612418983;337.13861084928004;337.7011344959713;5608.747606357713;5632.267805185325;5635.464630860067;5641.435856414367;5666.26338575985;5513.2005859150395;5520.613557051008;5534.861628459291;5545.861353466165;5557.472040156189;4171.186618609372;4221.24017676818;4362.454693163355;4381.518033016366;4382.12357528494;4352.891177720567;4376.474823021242;4385;4398.626116780078;4407.405000324963;4329.956700433003;4341.717788343748;4349.586789255031;4361.956380436202;4404.4934832494355;4253.489581250239;4327.3725309830215;4342.674299427524;4345.196138714348;4361.10292022971;3808.8573427971496;3834.731568790186;3839.5392552893554;3843.6925045996254;3858.344081506151;5366.7853285868905;5370.4629537045985;5373.596980226499;5401.216823560561;5405.945940540583;4840;4979.925301120486;4986.775595098229;4988.950110498885;5028.296038554606;5829.222087263383;5840.47435730782;5851.502622277111;5912.881742365129;5913.408659134096;4180.289350810339;4217.746935183868;4221.577842215754;4226.556211597769;4271.188474189925;5800.564957628152;6118.816435506942;6121.602095863755;6193.225846769154;6213.136059182272;4235.089455767024;4250.3199488081755;4255.4255175551525;4300.290452075373;4310.762908040025;4286.756840516216;4311.655067594585;4321.114171594815;4348.826046958149;4349.412829268008;4722.716637001791;4936.925946110811;4963.642269921758;4974.651774375759;4996.725180115056;5844.211031510777;5861.912071318934;5918.260217472816;5971.641701497924;5974.701264936736;1454.4473100221849;1465.2234315812636;1478.4825311141014;1481.052126638952;1485.3538710660896;942.5522876633681;958.6644674363916;1001.2440607341556;1016.3850870223408;1016.4003238089563;5619.185218143428;5656.575756818255;5681.57388195887;5697.774978379668;5737;5937.317208520989;5947.702614869326;5985.431384018511;6047.637141771508;6065.939340606537;5439.755211015514;5640.464155905182;5663.952168848776;5671.858203544862;5674.290713660793;3128.9217769555944;3191.457452233126;3193.377291428196;3204.230984563688;3218.5494030835703;5959.672218027963;6186.350433204539;6186.81439556814;6217.730528357117;6254.499640028786;6094.049904030668;6163.476104531075;6167.506599472032;6167.938320616826;6171.876562468726;6048.697565121726;6136.969315153396;6169.475594574422;6182.165407669907;6218.81343559694;5897.144913987362;5924.407559244041;5985.521158307238;6007.519398448201;6015.338312785678;5834.18321434991;5845.860057288788;5863.882722345615;5885.823425297248;5936.367498937654;6078.939210607838;6211.409916057967;6225.190725205694;6255.84266910623;6258.593191442542;4245.002424430195;4246.766427846374;4248.362745588187;4265.3318146394695;4266.504095104275;5863.120531920075;6018.91659501294;6034.607750496204;6039.758409663565;6163.907541386972;5853.1220316952795;5867.20792692998;5903.763849445974;5921.792737254175;5936.821895343147;5691.630044047124;5828.271466066742;5897.587168898136;5910.970445147746;5939.524838012862;5734.2258795062135;5764.250647415809;5768.480836724715;5771.2208851806145;5821.854453638693;5921.61509501881;5936.1986131871645;5940.1683764272175;5956.166136740773;6000.799840031924;5623.228682964853;5788.90010897928;5811.128330750421;5855.677937713296;5880.588358815013 00:10:28 INFO - PROCESS | 19376 | |5;yui.html;711.2389742975016;734.9893895893146;752.3792870881524;757.6628400361834;779.1740754799913;13604.523841665543;14606.342714577842;14608.707825843478;14628.853711462882;14673.192974386404;13387.93306033471;13431.798523022162;13438;13488.527901523448;13502.932485337584;661.1075048684262;771.3019717155955;783.1150799596448;794.566961006253;796.1759578835877;790.8734602463607;792.3977776889548;795.9124496305402;796.1043825696092;797.1948332184478;842.1872892658583;846.0524212881581;846.204567706354;846.8687353460224;847.2882778466087;833.5832083958021;837.4975014991018;838.8406202821475;840.5125027484045;842.061101871412;604.5314880967242;604.9334573196945;607.5625549604277;608.4979891589456;610.6275172144988;13748.65628359289;13855.445782168801;13868.514601988983;13869.861301386958;13898.58304250874;13834.446622135103;14163.78754318686;14194;14273.286335683175;14474.348654310581;12079.27524348542;12102.092343074304;12177.51289948401;12231.755364892651;12386.690332741664;3742.2515496900455;3776.9433458498142;3780.9054773630605;3804.5434547854434;3946.2699400610977;77311.22688773152;77367.22632773657;80059.19940800635;80692.59653701753;81193.18806811915;11544.365059921616;11671.416429178507;11707.239029463057;11723.912137627212;12150.696232594255;22168.334949951204;22171.66742498864;22319.3304200871;22424.551508970057;22429.88785056097;8027.397945154137;8327.167283271745;8648;8718.607662655195;8847.42491738035;4496.561100447825;4630.6758526902795;4643.721376717408;4678.134545109166;4679.859604211879;3602.621724718867;3643.599204087548;3721.4603882437436;3724.2365315110337;3740.17716102457;611.0772733172852;616.2697203813406;627.6736097229415;634.1185751804994;637.0087255381253;637.6397335505425;656.4485831901226;710.8258476673145;711.7224282529818;741.7960060983165;9197.356185066981;9832.508374581243;9951.751206219758;10005.19958403326;10102.747431314276;600.9699515024231;621.4003486635419;661.3155384177353;670.6579644381401;684.4182444921777;4767.380240568704;5041.193409054534;5067.265246539231;5074.949250507521;5110.0801855665595;70363.2963670367;71728.28271717216;106750.46624766827;107773;114365;62673.37326626766;76163.61918190373;97093.51453242688;97559;97992.51003745079;61545;85282;87713.56143219244;88184.55907720549;88428;9228.493569538803;9349.85975210386;9478.336516443782;9517.095875891779;9518.73150021414;50589.74705126451;52230.738846305525;52502;52650.47349526609;52838;69833.30166698471;70169;75737.24262757522;77696;79748.20251797407;11392.405063291311;11519.76960460803;11663.88336116628;11991.160618756603;12113.878861211275;13807.378667959765;13813.792793108312;13884.236366999912;14101.368236755208;14192.716145677236;12672.556460523838;12688.23870567769;12712.936435317764;13146.539980085474;13246.139000964906;12646.620601381974;12846.486140554272;13126.60620181396;13143.41856556469;13248.735025299247;12523.812142817682;12875.678108047;13070.673233169247;13334.933325333699;13503.39234734459;10438.269321147447;10489.318194317346;10577.894221057692;10648.73378165521;11047.226694131334;10114.696559103239;10208.2343824212;10561.260711750103;10688.946555267485;10722.731931701457 00:10:28 INFO - PROCESS | 19376 | __end_tp_report 00:10:28 INFO - PROCESS | 19376 | __start_cc_report 00:10:28 INFO - PROCESS | 19376 | _x_x_mozilla_cycle_collect,346 00:10:28 INFO - PROCESS | 19376 | __end_cc_report 00:10:28 INFO - PROCESS | 19376 | __startTimestamp1465456228830__endTimestamp 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | ------- Summary: start ------- 00:10:28 INFO - PROCESS | 19376 | Number of tests: 6 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#0] dojo.html Cycles:165 Average:5381.56 Median:5556.83 stddev:600.25 (10.8%) stddev-sans-first:575.63 00:10:28 INFO - PROCESS | 19376 | Values: 3134.6 3170.3 3174.3 3206.1 3217.4 5363.9 5365.7 5376.8 5454.8 5469.1 5298.9 5344.4 5357.5 5372.0 5413.1 4861.5 4877.0 4902.8 5012.8 5110.8 4931.5 5072.3 5107.7 5112.9 5117.4 4885.4 4908.2 4976.6 4984.2 5004.8 4966.7 4988.4 4991.1 4998.4 5049.0 4969.1 4970.5 4985.2 4990.1 5023.2 5124.6 5243.2 5262.8 5319.4 5332.0 5734.8 5741.9 5745.4 5748.9 5768.3 5667.1 5800.4 5801.8 5808.1 5829.5 5318.8 5372.9 5393.6 5429.3 5433.4 5919.5 5943.9 5944.1 5951.9 5960.6 5546.8 5711.2 5713.1 5725.2 5729.8 5783.3 5801.4 5802.2 5848.8 5850.8 5612.6 5675.4 5717.9 5737.7 5787.1 5733.5 5741.9 5796.2 5800.2 5836.2 4312.8 4325.3 4384.3 4415.0 4423.9 3950.8 3951.5 3957.9 3992.4 3995.1 5413.1 5529.1 5543.8 5550.1 5568.4 5779.4 5826.5 5827.5 5887.5 5899.9 5522.7 5549.9 5565.9 5567.0 5601.3 4910.1 4970.4 5044.1 5059.5 5103.4 5980.7 6033.2 6069.0 6080.1 6102.3 5836.4 5854.3 5873.8 5880.1 5886.9 5709.5 5941.8 5978.7 6029.2 6043.4 5716.0 5718.4 5724.9 5744.1 5776.7 5821.8 5848.7 5852.1 5873.7 5904.9 5438.1 5488.6 5567.7 5610.8 5638.7 5494.3 5535.9 5552.7 5587.7 5687.1 5493.3 5521.3 5523.0 5524.4 5563.8 5467.1 5624.3 5627.5 5634.2 5651.9 5556.8 5561.9 5586.5 5591.4 5654.0 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#1] ext.html Cycles:180 Average:59854.88 Median:41485.77 stddev:124215.52 (299.4%) stddev-sans-first:124484.21 00:10:28 INFO - PROCESS | 19376 | Values: 562.7 612.9 627.5 631.2 634.3 40413.0 44964.0 45080.8 45140.3 45337.8 45019.3 45345.8 45450.5 45513.8 45628.5 8799.7 8904.4 8921.2 8933.7 9001.3 8747.1 8814.5 8842.6 8845.8 8858.6 8849.6 8901.5 8914.1 8923.5 8927.9 8809.7 8843.0 8889.1 8891.1 8920.2 8833.8 8850.2 8892.2 8900.1 8933.6 34026.8 41780.8 41989.2 42255.4 42430.6 3271.4 3283.1 3461.2 3511.8 3757.2 31500.5 31564.2 32226.4 32856.3 32859.2 4119.2 4191.1 4211.4 4259.1 4399.0 289652.0 293723.0 294476.0 295202.0 295361.0 34673.7 36120.5 36242.6 36353.3 36442.3 37516.2 37536.4 37560.2 37578.2 37673.6 14880.4 14881.2 14890.6 14903.2 14919.2 13481.8 13523.9 13552.3 13568.9 13590.5 8336.1 8451.5 8479.9 8541.1 8547.8 3237.3 3252.5 3257.1 3297.5 3311.6 1036.2 1044.8 1084.3 1202.3 1227.2 32805.5 33309.8 33535.2 33707.7 33843.5 1120.9 1164.2 1167.5 1182.3 1187.0 16916.7 17283.3 17400.2 17450.8 17524.9 544205.0 552935.0 555471.0 557157.0 559669.0 60134.1 60424.4 60928.0 61100.4 61155.0 1367.1 1404.6 1416.3 1419.9 1435.8 31064.7 31549.4 31988.7 32213.0 32824.3 52552.0 53512.2 53633.0 53764.2 53849.2 496830.0 508184.0 510713.4 511932.0 512833.0 28581.7 28781.0 28839.4 28866.9 28963.6 48753.0 49853.8 49932.0 50164.5 51074.7 41636.6 42241.6 42710.8 42981.1 43066.0 40773.0 41446.2 41525.4 41968.8 42235.4 35081.0 41743.0 41990.2 42303.6 42432.6 36195.5 37585.0 37812.0 38051.6 38287.8 28259.9 28604.3 28646.1 28855.7 28894.6 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#2] jquery.html Cycles:180 Average:28148.85 Median:10976.67 stddev:79118.35 (720.8%) stddev-sans-first:79312.80 00:10:28 INFO - PROCESS | 19376 | Values: 366.4 375.2 376.5 379.6 386.6 17860.5 18836.7 18949.2 19839.9 19956.8 11911.0 12057.9 12320.0 12333.3 12333.9 5050.3 5262.4 5265.9 5266.3 5269.0 3824.3 5480.9 5742.7 5742.7 5769.7 5786.6 5788.4 5797.9 5807.2 5984.5 6157.6 6296.2 6310.1 6318.1 6323.1 5425.0 5551.3 5567.6 5613.9 5659.8 13190.5 13727.8 13759.1 13853.8 13914.5 2125.8 2219.7 2309.4 2325.8 2444.3 10161.9 10220.9 10385.3 10504.0 14317.6 1717.8 1878.8 1974.7 1996.5 2003.1 57558.4 82421.6 83421.0 84302.2 84461.2 10591.8 10850.2 11047.6 11059.3 11204.3 15515.1 15628.5 15719.6 15783.4 15810.1 8113.9 8268.3 8280.6 8336.3 8347.7 7456.4 7585.2 7791.9 7883.5 8047.2 4581.9 4762.1 4766.8 4812.1 4913.0 1807.7 1849.4 1950.9 1971.7 2003.2 951.2 977.9 997.6 1014.0 1101.6 16623.7 18865.4 19136.2 19271.0 19282.0 1040.1 1047.4 1050.4 1053.7 1091.5 10487.9 10833.8 10843.5 10853.8 10891.0 465776.0 471402.0 484170.0 485949.0 490498.0 81188.0 90250.0 91405.5 93463.5 94113.0 991.2 1016.8 1032.6 1056.3 1068.5 16708.5 16856.2 16927.9 17137.5 17545.6 41313.8 41782.8 41796.0 42116.8 42507.8 55293.0 56050.0 56596.2 57566.4 58060.7 8084.0 8261.9 8410.6 8478.7 8781.8 9441.7 10508.3 12897.9 13340.9 13537.5 11167.2 11486.5 11592.0 11669.5 11917.8 11442.3 11685.4 11730.4 11854.1 11859.3 5505.4 11299.8 11600.7 11736.8 12049.1 11602.2 12441.5 12475.8 12514.6 12819.1 12281.4 12337.2 12386.5 12540.7 12720.6 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#3] mootools.html Cycles:180 Average:5888.64 Median:2512.31 stddev:3394.85 (135.1%) stddev-sans-first:3387.92 00:10:28 INFO - PROCESS | 19376 | Values: 1440.8 1484.4 1579.4 1798.1 1808.8 7879.6 8499.4 8531.0 9197.5 9224.7 8495.4 8610.1 8672.3 8724.3 8742.7 2268.8 2283.2 2286.2 2287.5 2293.4 2242.9 2259.9 2261.3 2273.4 2291.9 2164.6 2167.6 2173.9 2175.0 2223.6 2136.7 2146.4 2148.4 2153.6 2162.4 2238.1 2243.4 2248.3 2262.1 2280.8 8689.7 8731.6 8758.3 8766.2 8779.0 5179.1 5320.9 5322.5 5325.0 5330.8 3280.3 3336.8 3494.6 3494.7 3500.1 1141.1 1148.8 1157.5 1166.2 1170.6 12645.9 12787.9 12797.4 12848.1 12870.7 4526.1 4568.2 4613.8 4654.7 4674.2 10593.3 10656.5 10669.7 10673.3 10679.1 5243.8 5289.5 5294.9 5297.9 5308.9 4112.5 4725.4 4846.2 4872.8 4919.2 3967.5 3985.1 4029.7 4086.9 4149.3 1214.4 1246.3 1251.2 1257.4 1262.8 1012.3 1026.6 1043.2 1056.2 1059.0 6009.6 6141.7 6270.2 6415.6 6520.2 454.2 456.4 470.8 471.9 494.0 4431.1 4553.7 4572.8 4592.4 4660.9 10969.1 11062.8 11074.9 11135.2 11166.4 10320.7 10664.0 11046.1 11150.6 11161.4 8208.3 8370.9 8377.3 8401.0 8473.5 6066.3 6343.9 6351.7 6365.9 6409.3 10135.5 10217.4 10274.4 10357.8 10394.8 10031.0 10180.4 10426.9 10453.2 10469.0 7261.7 7513.0 7745.8 7988.9 8241.6 8975.5 8988.8 9002.8 9010.3 9052.4 7919.4 8063.4 8113.7 8133.6 8134.3 7691.3 7733.1 7801.3 7865.7 7898.5 6579.8 7228.9 7254.3 7301.8 7302.5 5300.9 5312.2 5388.2 5423.0 5475.4 5239.3 5265.8 5273.6 5285.6 5340.1 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#4] prototype.html Cycles:180 Average:4935.16 Median:5649.01 stddev:1458.23 (25.8%) stddev-sans-first:1420.76 00:10:28 INFO - PROCESS | 19376 | Values: 330.1 331.3 332.8 337.1 337.7 5608.7 5632.3 5635.5 5641.4 5666.3 5513.2 5520.6 5534.9 5545.9 5557.5 4171.2 4221.2 4362.5 4381.5 4382.1 4352.9 4376.5 4385.0 4398.6 4407.4 4330.0 4341.7 4349.6 4362.0 4404.5 4253.5 4327.4 4342.7 4345.2 4361.1 3808.9 3834.7 3839.5 3843.7 3858.3 5366.8 5370.5 5373.6 5401.2 5405.9 4840.0 4979.9 4986.8 4989.0 5028.3 5829.2 5840.5 5851.5 5912.9 5913.4 4180.3 4217.7 4221.6 4226.6 4271.2 5800.6 6118.8 6121.6 6193.2 6213.1 4235.1 4250.3 4255.4 4300.3 4310.8 4286.8 4311.7 4321.1 4348.8 4349.4 4722.7 4936.9 4963.6 4974.7 4996.7 5844.2 5861.9 5918.3 5971.6 5974.7 1454.4 1465.2 1478.5 1481.1 1485.4 942.6 958.7 1001.2 1016.4 1016.4 5619.2 5656.6 5681.6 5697.8 5737.0 5937.3 5947.7 5985.4 6047.6 6065.9 5439.8 5640.5 5664.0 5671.9 5674.3 3128.9 3191.5 3193.4 3204.2 3218.5 5959.7 6186.4 6186.8 6217.7 6254.5 6094.0 6163.5 6167.5 6167.9 6171.9 6048.7 6137.0 6169.5 6182.2 6218.8 5897.1 5924.4 5985.5 6007.5 6015.3 5834.2 5845.9 5863.9 5885.8 5936.4 6078.9 6211.4 6225.2 6255.8 6258.6 4245.0 4246.8 4248.4 4265.3 4266.5 5863.1 6018.9 6034.6 6039.8 6163.9 5853.1 5867.2 5903.8 5921.8 5936.8 5691.6 5828.3 5897.6 5911.0 5939.5 5734.2 5764.3 5768.5 5771.2 5821.9 5921.6 5936.2 5940.2 5956.2 6000.8 5623.2 5788.9 5811.1 5855.7 5880.6 00:10:28 INFO - PROCESS | 19376 | 00:10:28 INFO - PROCESS | 19376 | [#5] yui.html Cycles:180 Average:19672.54 Median:4904.29 stddev:27664.77 (564.1%) stddev-sans-first:27705.74 00:10:28 INFO - PROCESS | 19376 | Values: 711.2 735.0 752.4 757.7 779.2 13604.5 14606.3 14608.7 14628.9 14673.2 13387.9 13431.8 13438.0 13488.5 13502.9 661.1 771.3 783.1 794.6 796.2 790.9 792.4 795.9 796.1 797.2 842.2 846.1 846.2 846.9 847.3 833.6 837.5 838.8 840.5 842.1 604.5 604.9 607.6 608.5 610.6 13748.7 13855.4 13868.5 13869.9 13898.6 13834.4 14163.8 14194.0 14273.3 14474.3 12079.3 12102.1 12177.5 12231.8 12386.7 3742.3 3776.9 3780.9 3804.5 3946.3 77311.2 77367.2 80059.2 80692.6 81193.2 11544.4 11671.4 11707.2 11723.9 12150.7 22168.3 22171.7 22319.3 22424.6 22429.9 8027.4 8327.2 8648.0 8718.6 8847.4 4496.6 4630.7 4643.7 4678.1 4679.9 3602.6 3643.6 3721.5 3724.2 3740.2 611.1 616.3 627.7 634.1 637.0 637.6 656.4 710.8 711.7 741.8 9197.4 9832.5 9951.8 10005.2 10102.7 601.0 621.4 661.3 670.7 684.4 4767.4 5041.2 5067.3 5074.9 5110.1 70363.3 71728.3 106750.5 107773.0 114365.0 62673.4 76163.6 97093.5 97559.0 97992.5 61545.0 85282.0 87713.6 88184.6 88428.0 9228.5 9349.9 9478.3 9517.1 9518.7 50589.7 52230.7 52502.0 52650.5 52838.0 69833.3 70169.0 75737.2 77696.0 79748.2 11392.4 11519.8 11663.9 11991.2 12113.9 13807.4 13813.8 13884.2 14101.4 14192.7 12672.6 12688.2 12712.9 13146.5 13246.1 12646.6 12846.5 13126.6 13143.4 13248.7 12523.8 12875.7 13070.7 13334.9 13503.4 10438.3 10489.3 10577.9 10648.7 11047.2 10114.7 10208.2 10561.3 10688.9 10722.7 00:10:28 INFO - PROCESS | 19376 | -------- Summary: end -------- 00:10:28 INFO - PROCESS | 19376 | 00:10:29 INFO - TEST-INFO | 19376: exit 0 00:10:29 INFO - TEST-OK | dromaeo_css | took 1110591ms 00:10:29 INFO - TEST-START | kraken 00:10:29 INFO - operating with platform_type : linux_ 00:10:29 INFO - Initialising browser for kraken test... 00:10:29 INFO - TEST-INFO | started process 19607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZKKfv/profile http://localhost:33115/getInfo.html) 00:10:33 INFO - PROCESS | 19607 | __metrics Screen width/height:1600/1200 00:10:33 INFO - PROCESS | 19607 | colorDepth:24 00:10:33 INFO - PROCESS | 19607 | Browser inner width/height: 1024/697 00:10:33 INFO - PROCESS | 19607 | __metrics 00:10:34 ERROR - PROCESS | 19607 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 00:10:35 INFO - TEST-INFO | 19607: exit 0 00:10:35 INFO - Browser initialized. 00:10:35 INFO - Running cycle 1/1 for kraken test... 00:10:35 INFO - TEST-INFO | started process 19727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZKKfv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:10:47 INFO - PROCESS | 19727 | RSS: Main: 167092224 00:10:47 INFO - PROCESS | 19727 | 00:10:49 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33115/tests/kraken/driver.html?testName=audio-beat-detection) 00:10:50 INFO - PROCESS | 19727 | RSS: Main: 172199936 00:10:50 INFO - PROCESS | 19727 | 00:10:53 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33115/tests/kraken/driver.html?testName=audio-dft) 00:10:53 INFO - PROCESS | 19727 | RSS: Main: 171261952 00:10:53 INFO - PROCESS | 19727 | 00:10:56 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33115/tests/kraken/driver.html?testName=audio-fft) 00:10:57 INFO - PROCESS | 19727 | RSS: Main: 166408192 00:10:57 INFO - PROCESS | 19727 | 00:10:59 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33115/tests/kraken/driver.html?testName=audio-oscillator) 00:11:00 INFO - PROCESS | 19727 | RSS: Main: 166932480 00:11:00 INFO - PROCESS | 19727 | 00:11:02 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:11:02 INFO - PROCESS | 19727 | RSS: Main: 167411712 00:11:02 INFO - PROCESS | 19727 | 00:11:06 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33115/tests/kraken/driver.html?testName=imaging-darkroom) 00:11:06 INFO - PROCESS | 19727 | RSS: Main: 168034304 00:11:06 INFO - PROCESS | 19727 | 00:11:10 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33115/tests/kraken/driver.html?testName=imaging-desaturate) 00:11:10 INFO - PROCESS | 19727 | RSS: Main: 165179392 00:11:10 INFO - PROCESS | 19727 | 00:11:13 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33115/tests/kraken/driver.html?testName=json-parse-financial) 00:11:14 INFO - PROCESS | 19727 | RSS: Main: 166801408 00:11:14 INFO - PROCESS | 19727 | 00:11:15 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:11:16 INFO - PROCESS | 19727 | RSS: Main: 167542784 00:11:16 INFO - PROCESS | 19727 | 00:11:18 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:11:18 INFO - PROCESS | 19727 | RSS: Main: 167526400 00:11:18 INFO - PROCESS | 19727 | 00:11:21 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:11:21 INFO - PROCESS | 19727 | RSS: Main: 168108032 00:11:21 INFO - PROCESS | 19727 | 00:11:24 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:11:24 INFO - PROCESS | 19727 | RSS: Main: 167743488 00:11:24 INFO - PROCESS | 19727 | 00:11:27 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:11:28 INFO - PROCESS | 19727 | RSS: Main: 167682048 00:11:28 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | Cycle 1(1): loaded http://localhost:33115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33115/tests/kraken/driver.html?testName=ai-astar) 00:11:30 INFO - PROCESS | 19727 | RSS: Main: 168607744 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | __start_tp_report 00:11:30 INFO - PROCESS | 19727 | _x_x_mozilla_page_load 00:11:30 INFO - PROCESS | 19727 | _x_x_mozilla_page_load_details 00:11:30 INFO - PROCESS | 19727 | |i|pagename|runs| 00:11:30 INFO - PROCESS | 19727 | |0;ai-astar;113;117;112;112;114;113;112;111;115;111 00:11:30 INFO - PROCESS | 19727 | |1;audio-beat-detection;158;130;158;183;127;156;160;130;188;128 00:11:30 INFO - PROCESS | 19727 | |2;audio-dft;164;164;163;163;163;170;169;161;162;162 00:11:30 INFO - PROCESS | 19727 | |3;audio-fft;75;76;79;168;75;75;74;77;165;76 00:11:30 INFO - PROCESS | 19727 | |4;audio-oscillator;85;84;143;84;86;85;138;86;85;142 00:11:30 INFO - PROCESS | 19727 | |5;imaging-gaussian-blur;117;117;117;118;117;119;118;119;118;117 00:11:30 INFO - PROCESS | 19727 | |6;imaging-darkroom;147;147;147;149;146;147;147;148;148;148 00:11:30 INFO - PROCESS | 19727 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;96 00:11:30 INFO - PROCESS | 19727 | |8;json-parse-financial;57;57;58;57;59;59;65;56;56;57 00:11:30 INFO - PROCESS | 19727 | |9;json-stringify-tinderbox;61;62;62;62;61;61;61;63;62;61 00:11:30 INFO - PROCESS | 19727 | |10;stanford-crypto-aes;84;87;81;80;82;81;82;81;102;85 00:11:30 INFO - PROCESS | 19727 | |11;stanford-crypto-ccm;129;129;131;133;128;134;132;135;125;126 00:11:30 INFO - PROCESS | 19727 | |12;stanford-crypto-pbkdf2;161;165;160;164;164;171;162;162;163;166 00:11:30 INFO - PROCESS | 19727 | |13;stanford-crypto-sha256-iterative;65;64;64;63;68;67;64;66;64;63 00:11:30 INFO - PROCESS | 19727 | __end_tp_report 00:11:30 INFO - PROCESS | 19727 | __start_cc_report 00:11:30 INFO - PROCESS | 19727 | _x_x_mozilla_cycle_collect,871 00:11:30 INFO - PROCESS | 19727 | __end_cc_report 00:11:30 INFO - PROCESS | 19727 | __startTimestamp1465456290308__endTimestamp 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | ------- Summary: start ------- 00:11:30 INFO - PROCESS | 19727 | Number of tests: 14 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 00:11:30 INFO - PROCESS | 19727 | Values: 113.0 117.0 112.0 112.0 114.0 113.0 112.0 111.0 115.0 111.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.00 stddev:22.55 (14.3%) stddev-sans-first:23.81 00:11:30 INFO - PROCESS | 19727 | Values: 158.0 130.0 158.0 183.0 127.0 156.0 160.0 130.0 188.0 128.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.00 (1.8%) stddev-sans-first:3.18 00:11:30 INFO - PROCESS | 19727 | Values: 164.0 164.0 163.0 163.0 163.0 170.0 169.0 161.0 162.0 162.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.24 (50.7%) stddev-sans-first:39.94 00:11:30 INFO - PROCESS | 19727 | Values: 75.0 76.0 79.0 168.0 75.0 75.0 74.0 77.0 165.0 76.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:85.00 stddev:27.09 (31.9%) stddev-sans-first:28.04 00:11:30 INFO - PROCESS | 19727 | Values: 85.0 84.0 143.0 84.0 86.0 85.0 138.0 86.0 85.0 142.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 00:11:30 INFO - PROCESS | 19727 | Values: 117.0 117.0 117.0 118.0 117.0 119.0 118.0 119.0 118.0 117.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 00:11:30 INFO - PROCESS | 19727 | Values: 147.0 147.0 147.0 149.0 146.0 147.0 147.0 148.0 148.0 148.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:11:30 INFO - PROCESS | 19727 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:2.64 (4.6%) stddev-sans-first:2.77 00:11:30 INFO - PROCESS | 19727 | Values: 57.0 57.0 58.0 57.0 59.0 59.0 65.0 56.0 56.0 57.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 00:11:30 INFO - PROCESS | 19727 | Values: 61.0 62.0 62.0 62.0 61.0 61.0 61.0 63.0 62.0 61.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.00 stddev:6.52 (8.0%) stddev-sans-first:6.91 00:11:30 INFO - PROCESS | 19727 | Values: 84.0 87.0 81.0 80.0 82.0 81.0 82.0 81.0 102.0 85.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:131.50 stddev:3.36 (2.6%) stddev-sans-first:3.54 00:11:30 INFO - PROCESS | 19727 | Values: 129.0 129.0 131.0 133.0 128.0 134.0 132.0 135.0 125.0 126.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:3.12 (1.9%) stddev-sans-first:3.14 00:11:30 INFO - PROCESS | 19727 | Values: 161.0 165.0 160.0 164.0 164.0 171.0 162.0 162.0 163.0 166.0 00:11:30 INFO - PROCESS | 19727 | 00:11:30 INFO - PROCESS | 19727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:1.69 (2.6%) stddev-sans-first:1.79 00:11:30 INFO - PROCESS | 19727 | Values: 65.0 64.0 64.0 63.0 68.0 67.0 64.0 66.0 64.0 63.0 00:11:30 INFO - PROCESS | 19727 | -------- Summary: end -------- 00:11:30 INFO - PROCESS | 19727 | 00:11:31 INFO - TEST-INFO | 19727: exit 0 00:11:31 INFO - TEST-OK | kraken | took 61738ms 00:11:31 INFO - SUITE-END | took 1172s 00:11:31 INFO - Completed test suite (00:19:32) 00:11:31 INFO - javascript benchmark 00:11:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7185.135049722107, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.5768321276623, 3170.2708377073286, 3174.3492584020278, 3206.134343727194, 3217.4047801156803, 5363.9463605363935, 5365.6512326698785, 5376.8118115865955, 5454.754536045877, 5469.124940009599, 5298.92051619226, 5344.385395679498, 5357.544608708265, 5372.0330340538685, 5413.106837371839, 4861.513848615145, 4877.0, 4902.754862256891, 5012.849614511552, 5110.770015349318, 4931.482194369593, 5072.26452164436, 5107.69353838769, 5112.872178195537, 5117.437081920985, 4885.413750349963, 4908.239222920453, 4976.576990955773, 4984.152694042022, 5004.799808007675, 4966.726830024347, 4988.426330971948, 4991.101601711691, 4998.425181104183, 5049.040682270357, 4969.130402179604, 4970.502949705036, 4985.1774457214515, 4990.101781679296, 5023.2214006828635, 5124.615653825978, 5243.187305967581, 5262.815801446931, 5319.441458646825, 5331.973340133313, 5734.799282025151, 5741.856453588652, 5745.396733342981, 5748.913766293509, 5768.336641286264, 5667.121596152603, 5800.361960184377, 5801.796937107181, 5808.12878068289, 5829.4753472187285, 5318.787248510055, 5372.946270537283, 5393.649412788156, 5429.294191755086, 5433.429489903543, 5919.526437884959, 5943.881122377528, 5944.138099975479, 5951.880962380728, 5960.552958528127, 5546.833594992157, 5711.228984087178, 5713.057345538023, 5725.227094342211, 5729.799457018984, 5783.334916484658, 5801.361850196559, 5802.158686990363, 5848.824535263949, 5850.824475265749, 5612.550995920398, 5675.3757086720425, 5717.914231286534, 5737.655740655574, 5787.074068149076, 5733.512651424676, 5741.942580574224, 5796.246487956539, 5800.187973683687, 5836.212111364996, 4312.7627980461375, 4325.286327755948, 4384.254676704968, 4415.0, 4423.889402764892, 3950.7827069511454, 3951.5258169019903, 3957.861474848424, 3992.4210989406374, 3995.1210733638554, 5413.079776438015, 5529.060059789846, 5543.750531226105, 5550.084236101079, 5568.415316391802, 5779.3642699303045, 5826.504747096459, 5827.475527202572, 5887.528997680175, 5899.911501327483, 5522.723863806794, 5549.861253468614, 5565.916511252334, 5566.972165139229, 5601.327840659147, 4910.116179087799, 4970.378702662168, 5044.066847633199, 5059.519345662156, 5103.387593488805, 5980.671063091485, 6033.18551995475, 6069.0, 6080.087986802015, 6102.328743838174, 5836.416358364129, 5854.326752423355, 5873.823785286449, 5880.0591905295805, 5886.911696324644, 5709.54323654115, 5941.762329506944, 5978.701064946648, 6029.216201893902, 6043.36544662804, 5716.0, 5718.399568045295, 5724.914126288026, 5744.138379243147, 5776.740046697824, 5821.79623713185, 5848.736806843617, 5852.122181672783, 5873.676947767914, 5904.911426328695, 5438.102713052302, 5488.56091512686, 5567.721613919369, 5610.775568977195, 5638.689872057076, 5494.340679118372, 5535.916961245504, 5552.7223638818705, 5587.720613969204, 5687.146927960839, 5493.2858728366655, 5521.254630624814, 5522.972385138049, 5524.4199359068325, 5563.805266815642, 5467.125259958547, 5624.3250809903075, 5627.549796016391, 5634.154876768517, 5651.858703532444, 5556.833295001156, 5561.888762224814, 5586.497215250484, 5591.440855914376, 5654.038813401814], "value": 5341.938136521316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6792728144957, 612.8559788449713, 627.5293529852612, 631.1574048645059, 634.3181080338637, 40413.0, 44964.0, 45080.77459612701, 45140.3228951566, 45337.773311133395, 45019.324710129375, 45345.77327113368, 45450.54549454505, 45513.772431137884, 45628.543714562846, 8799.69201077964, 8904.376693631448, 8921.241694455979, 8933.687320943769, 9001.279897608176, 8747.081556436578, 8814.471131732085, 8842.557872106401, 8845.823083538326, 8858.626912828522, 8849.646014159458, 8901.510416927067, 8914.108589141098, 8923.509206993613, 8927.866082008775, 8809.691660791841, 8842.955785221066, 8889.066648001932, 8891.11088891109, 8920.152585504367, 8833.779155521099, 8850.159234872677, 8892.244159246471, 8900.065493123193, 8933.553322333857, 34026.82986585076, 41780.79109604463, 41989.1602167958, 42255.366169507484, 42430.57569424328, 3271.4275001874576, 3283.0807373935336, 3461.152017755641, 3511.806850623215, 3757.1734218471893, 31500.527492087636, 31564.210894727585, 32226.35547289041, 32856.34287314241, 32859.17852053694, 4119.155573107506, 4191.11986482839, 4211.368294755781, 4259.084296876155, 4399.0, 289652.0, 293722.99999999785, 294476.0, 295202.0, 295361.0, 34673.653263467546, 36120.458193127124, 36242.63757362445, 36353.272934541164, 36442.27115457676, 37516.249675006344, 37536.43695344572, 37560.248795023945, 37578.248435031695, 37673.62326376756, 14880.404783808526, 14881.181535015678, 14890.627734306512, 14903.180325082008, 14919.179445130405, 13481.797773033413, 13523.932380338036, 13552.254625995467, 13568.93215533916, 13590.524331648345, 8336.083030866599, 8451.492910425393, 8479.872801907977, 8541.060483346826, 8547.786305342415, 3237.336346049054, 3252.454564966726, 3257.088015355704, 3297.5383446317533, 3311.56599899074, 1036.2176556699644, 1044.848894947914, 1084.3397465231478, 1202.2786328203008, 1227.2084505493906, 32805.507917381256, 33309.83345083259, 33535.16162095918, 33707.66292337045, 33843.4923476148, 1120.8598925134359, 1164.1559869095008, 1167.4512978899904, 1182.2906256246183, 1186.9643910682694, 16916.661666766595, 17283.308667653153, 17400.21699023547, 17450.825491745174, 17524.91237543804, 544205.0, 552935.0, 555471.0, 557157.0, 559669.0, 60134.09798853021, 60424.39575604276, 60928.0, 61100.388996110356, 61155.0, 1367.09771550776, 1404.6137312239216, 1416.2706206303762, 1419.9432022719182, 1435.7846323051626, 31064.68935310618, 31549.369012620078, 31988.68011319857, 32213.0, 32824.343513129126, 52552.0, 53512.19731704106, 53633.0, 53764.19353709776, 53849.19226211531, 496830.0, 508184.0, 510713.3571985693, 511932.0, 512833.0, 28581.714182858737, 28781.0, 28839.42321153523, 28866.855665721538, 28963.565546516398, 48753.0, 49853.75073124611, 49932.0, 50164.49835501598, 51074.74462627663, 41636.58363416327, 42241.57758422376, 42710.78644606757, 42981.1403771929, 43066.0, 40773.0, 41446.1710765789, 41525.37711934263, 41968.79015604902, 42235.36646950237, 35081.0, 41743.0, 41990.16019679528, 42303.576964229964, 42432.575674242864, 36195.457068144526, 37585.0, 37812.0, 38051.61948380592, 38287.80856095702, 28259.858700706365, 28604.284892877844, 28646.140615781558, 28855.711442885302, 28894.566581501716], "value": 18957.168883878807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3826452427659, 375.1521561271526, 376.49361608636383, 379.5521284883839, 386.63463027439064, 17860.464186074423, 18836.717449238273, 18949.242030318786, 19839.900800495976, 19956.800431995656, 11910.95027690585, 12057.939710301458, 12320.0, 12333.260004399719, 12333.876661233408, 5050.3434553508, 5262.394824595163, 5265.9473405266035, 5266.289050978126, 5269.0, 3824.273388056274, 5480.862978425552, 5742.6841523716175, 5742.7415766290615, 5769.6826674533095, 5786.623869448494, 5788.392218817026, 5797.942020579803, 5807.186993820868, 5984.461398474136, 6157.6305421674615, 6296.212973378328, 6310.053491976218, 6318.147050148263, 6323.051542268673, 5425.0, 5551.278333816618, 5567.582431317667, 5613.859653508695, 5659.801906933279, 13190.47238110484, 13727.794083088762, 13759.10565813219, 13853.792193117111, 13914.51299204523, 2125.787421257877, 2219.6892435059103, 2309.3533810533077, 2325.813934885205, 2444.303373538533, 10161.949190254076, 10220.948895255551, 10385.324953877975, 10504.0, 14317.642058948506, 1717.7681013063202, 1878.8496920246348, 1974.6939224420237, 1996.5308152584132, 2003.1086166655843, 57558.424415755726, 82421.58789206075, 83421.0, 84302.15697843004, 84461.15538844594, 10591.788164236827, 10850.186236032328, 11047.558097676163, 11059.336439813476, 11204.327740335606, 15515.146666933202, 15628.531144065697, 15719.607009824846, 15783.36866525349, 15810.130442825755, 8113.918860811435, 8268.2558569729, 8280.58597070144, 8336.333093352638, 8347.707830225912, 7456.3662088721985, 7585.241475852481, 7791.883121753178, 7883.487573307832, 8047.155048719917, 4581.885452863638, 4762.119007983534, 4766.833160839354, 4812.06164797861, 4913.0, 1807.737627651228, 1849.3540748733637, 1950.9219631214592, 1971.7338159348305, 2003.2187446895723, 951.219999600335, 977.8924318324979, 997.6009596161593, 1013.9695809125737, 1101.5593762495066, 16623.735004938488, 18865.434036978913, 19136.234550618097, 19271.0, 19282.0, 1040.147079394904, 1047.3768107975743, 1050.417018554694, 1053.72603123187, 1091.4870011094772, 10487.852361389183, 10833.767458013848, 10843.481108762313, 10853.79907804803, 10890.990343947056, 465776.0, 471402.0, 484170.0, 485949.0, 490498.0, 81188.0, 90250.0, 91405.54297228472, 93463.53268233615, 94113.0, 991.2169386184977, 1016.7763092119721, 1032.6230925712212, 1056.2606175677056, 1068.5084860963889, 16708.49874503767, 16856.15719214059, 16927.915360423118, 17137.485875423758, 17545.649087018443, 41313.79343103385, 41782.79108604437, 41796.0, 42116.78941605272, 42507.7874610625, 55293.0, 56050.0, 56596.15105773335, 57566.424335756106, 58060.709696451246, 8084.0, 8261.917380826115, 8410.612893077167, 8478.74563763088, 8781.824363512822, 9441.669541566012, 10508.264421490423, 12897.871021290042, 13340.86659133435, 13537.526186583422, 11167.162462815484, 11486.50675412191, 11592.0, 11669.533218671158, 11917.761644766882, 11442.256253343507, 11685.415729213675, 11730.354830484064, 11854.110941679237, 11859.347735874264, 5505.394406615189, 11299.830502542303, 11600.709982250512, 11736.76526469483, 12049.096317776026, 11602.18784685064, 12441.502339906303, 12475.75048499043, 12514.623391427118, 12819.102662813513, 12281.44733487013, 12337.198082124632, 12386.504539818307, 12540.686482838002, 12720.554780583005], "value": 8996.069421960185, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.82710074791, 1484.3913995261944, 1579.3603590545827, 1798.1009495252374, 1808.846248068914, 7879.645415956282, 8499.362547808909, 8530.957345213274, 9197.494137822425, 9224.677136300223, 8495.36284778641, 8610.138986101387, 8672.30621550276, 8724.258438032775, 8742.737717868458, 2268.8298377621663, 2283.2465286455513, 2286.1541229744935, 2287.5196208796174, 2293.415179129328, 2242.876641784709, 2259.89830457629, 2261.2876943762744, 2273.3748219239674, 2291.862488250702, 2164.6428339323993, 2167.6206663833846, 2173.9239126630573, 2175.0321107107343, 2223.55528894221, 2136.6688163334707, 2146.37755051035, 2148.4199266198193, 2153.5585205033008, 2162.426956856434, 2238.1383167480476, 2243.4054975431523, 2248.347979086063, 2262.072550254404, 2280.8403411761183, 8689.6524139035, 8731.563421828947, 8758.255548278405, 8766.167214114712, 8779.03430622631, 5179.067767801795, 5320.893582128375, 5322.494363035506, 5324.973375133139, 5330.786768529293, 3280.3439312137666, 3336.8331583420972, 3494.5806503219524, 3494.72042236623, 3500.1074725944977, 1141.132739118276, 1148.7650775416378, 1157.4964890272759, 1166.1894982986828, 1170.5902933973127, 12645.873541264562, 12787.936060319731, 12797.360131993457, 12848.100632955604, 12870.67823304425, 4526.117407105583, 4568.177728008924, 4613.815447382067, 4654.720716756938, 4674.182018146811, 10593.31143475687, 10656.520456579472, 10669.679909602724, 10673.30623509485, 10679.09227715653, 5243.790248390098, 5289.523942845162, 5294.92057619136, 5297.947020529746, 5308.946910530923, 4112.527059388149, 4725.432948046257, 4846.151923413388, 4872.829450969199, 4919.237518184687, 3967.5238971323047, 3985.143194213258, 4029.738067025634, 4086.9182616347507, 4149.2738770715005, 1214.3685283652628, 1246.3207551884245, 1251.161721646499, 1257.3964497041472, 1262.835831341938, 1012.3015119567475, 1026.6047571684956, 1043.1915265669168, 1056.2289528644133, 1058.9682309530726, 6009.609375390585, 6141.662208578482, 6270.2475702915945, 6415.582987105823, 6520.152380190545, 454.2051410032443, 456.4363011680572, 470.8257944560535, 471.90797794430443, 493.97777100030584, 4431.135928493977, 4553.704009239389, 4572.771361431982, 4592.3570700101345, 4660.906781864343, 10969.067629251444, 11062.778744425066, 11074.944625276983, 11135.164862635334, 11166.441677916235, 10320.741981450525, 10664.0, 11046.061084807881, 11150.60972865962, 11161.386123763272, 8208.302294305051, 8370.916290837014, 8377.287930525974, 8401.033881103507, 8473.533955632376, 6066.272047354346, 6343.873122537616, 6351.745930162741, 6365.90451143224, 6409.3270206629495, 10135.49322533885, 10217.438040907822, 10274.383536987805, 10357.792844142925, 10394.844077338696, 10031.0, 10180.440075795903, 10426.947865260625, 10453.163746900382, 10469.0, 7261.709531618676, 7512.962435187789, 7745.806354841174, 7988.880166797619, 8241.629126689433, 8975.506347150707, 8988.775280618036, 9002.774930626787, 9010.324225682969, 9052.411593246681, 7919.445638805229, 8063.435559510778, 8113.716019939274, 8133.633986470505, 8134.267915887599, 7691.346235570039, 7733.110692270236, 7801.336886364723, 7865.685372585032, 7898.486598371088, 6579.835504112435, 7228.855422891407, 7254.274572542704, 7301.817454563678, 7302.488825782144, 5300.867478313073, 5312.203169524602, 5388.191771234347, 5423.0, 5475.397706252389, 5239.345081864767, 5265.763040663256, 5273.5781137509675, 5285.603579731459, 5340.0921843287515], "value": 4613.684860495852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.11529102006614, 331.3009549849817, 332.8119612418983, 337.13861084928004, 337.7011344959713, 5608.747606357713, 5632.267805185325, 5635.464630860067, 5641.435856414367, 5666.26338575985, 5513.2005859150395, 5520.613557051008, 5534.861628459291, 5545.861353466165, 5557.472040156189, 4171.186618609372, 4221.24017676818, 4362.454693163355, 4381.518033016366, 4382.12357528494, 4352.891177720567, 4376.474823021242, 4385.0, 4398.626116780078, 4407.405000324963, 4329.956700433003, 4341.717788343748, 4349.586789255031, 4361.956380436202, 4404.4934832494355, 4253.489581250239, 4327.3725309830215, 4342.674299427524, 4345.196138714348, 4361.10292022971, 3808.8573427971496, 3834.731568790186, 3839.5392552893554, 3843.6925045996254, 3858.344081506151, 5366.7853285868905, 5370.4629537045985, 5373.596980226499, 5401.216823560561, 5405.945940540583, 4840.0, 4979.925301120486, 4986.775595098229, 4988.950110498885, 5028.296038554606, 5829.222087263383, 5840.47435730782, 5851.502622277111, 5912.881742365129, 5913.408659134096, 4180.289350810339, 4217.746935183868, 4221.577842215754, 4226.556211597769, 4271.188474189925, 5800.564957628152, 6118.816435506942, 6121.602095863755, 6193.225846769154, 6213.136059182272, 4235.089455767024, 4250.3199488081755, 4255.4255175551525, 4300.290452075373, 4310.762908040025, 4286.756840516216, 4311.655067594585, 4321.114171594815, 4348.826046958149, 4349.412829268008, 4722.716637001791, 4936.925946110811, 4963.642269921758, 4974.651774375759, 4996.725180115056, 5844.211031510777, 5861.912071318934, 5918.260217472816, 5971.641701497924, 5974.701264936736, 1454.4473100221849, 1465.2234315812636, 1478.4825311141014, 1481.052126638952, 1485.3538710660896, 942.5522876633681, 958.6644674363916, 1001.2440607341556, 1016.3850870223408, 1016.4003238089563, 5619.185218143428, 5656.575756818255, 5681.57388195887, 5697.774978379668, 5737.0, 5937.317208520989, 5947.702614869326, 5985.431384018511, 6047.637141771508, 6065.939340606537, 5439.755211015514, 5640.464155905182, 5663.952168848776, 5671.858203544862, 5674.290713660793, 3128.9217769555944, 3191.457452233126, 3193.377291428196, 3204.230984563688, 3218.5494030835703, 5959.672218027963, 6186.350433204539, 6186.81439556814, 6217.730528357117, 6254.499640028786, 6094.049904030668, 6163.476104531075, 6167.506599472032, 6167.938320616826, 6171.876562468726, 6048.697565121726, 6136.969315153396, 6169.475594574422, 6182.165407669907, 6218.81343559694, 5897.144913987362, 5924.407559244041, 5985.521158307238, 6007.519398448201, 6015.338312785678, 5834.18321434991, 5845.860057288788, 5863.882722345615, 5885.823425297248, 5936.367498937654, 6078.939210607838, 6211.409916057967, 6225.190725205694, 6255.84266910623, 6258.593191442542, 4245.002424430195, 4246.766427846374, 4248.362745588187, 4265.3318146394695, 4266.504095104275, 5863.120531920075, 6018.91659501294, 6034.607750496204, 6039.758409663565, 6163.907541386972, 5853.1220316952795, 5867.20792692998, 5903.763849445974, 5921.792737254175, 5936.821895343147, 5691.630044047124, 5828.271466066742, 5897.587168898136, 5910.970445147746, 5939.524838012862, 5734.2258795062135, 5764.250647415809, 5768.480836724715, 5771.2208851806145, 5821.854453638693, 5921.61509501881, 5936.1986131871645, 5940.1683764272175, 5956.166136740773, 6000.799840031924, 5623.228682964853, 5788.90010897928, 5811.128330750421, 5855.677937713296, 5880.588358815013], "value": 4463.433937309887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.2389742975016, 734.9893895893146, 752.3792870881524, 757.6628400361834, 779.1740754799913, 13604.523841665543, 14606.342714577842, 14608.707825843478, 14628.853711462882, 14673.192974386404, 13387.93306033471, 13431.798523022162, 13438.0, 13488.527901523448, 13502.932485337584, 661.1075048684262, 771.3019717155955, 783.1150799596448, 794.566961006253, 796.1759578835877, 790.8734602463607, 792.3977776889548, 795.9124496305402, 796.1043825696092, 797.1948332184478, 842.1872892658583, 846.0524212881581, 846.204567706354, 846.8687353460224, 847.2882778466087, 833.5832083958021, 837.4975014991018, 838.8406202821475, 840.5125027484045, 842.061101871412, 604.5314880967242, 604.9334573196945, 607.5625549604277, 608.4979891589456, 610.6275172144988, 13748.65628359289, 13855.445782168801, 13868.514601988983, 13869.861301386958, 13898.58304250874, 13834.446622135103, 14163.78754318686, 14194.0, 14273.286335683175, 14474.348654310581, 12079.27524348542, 12102.092343074304, 12177.51289948401, 12231.755364892651, 12386.690332741664, 3742.2515496900455, 3776.9433458498142, 3780.9054773630605, 3804.5434547854434, 3946.2699400610977, 77311.22688773152, 77367.22632773657, 80059.19940800635, 80692.59653701753, 81193.18806811915, 11544.365059921616, 11671.416429178507, 11707.239029463057, 11723.912137627212, 12150.696232594255, 22168.334949951204, 22171.66742498864, 22319.3304200871, 22424.551508970057, 22429.88785056097, 8027.397945154137, 8327.167283271745, 8648.0, 8718.607662655195, 8847.42491738035, 4496.561100447825, 4630.6758526902795, 4643.721376717408, 4678.134545109166, 4679.859604211879, 3602.621724718867, 3643.599204087548, 3721.4603882437436, 3724.2365315110337, 3740.17716102457, 611.0772733172852, 616.2697203813406, 627.6736097229415, 634.1185751804994, 637.0087255381253, 637.6397335505425, 656.4485831901226, 710.8258476673145, 711.7224282529818, 741.7960060983165, 9197.356185066981, 9832.508374581243, 9951.751206219758, 10005.19958403326, 10102.747431314276, 600.9699515024231, 621.4003486635419, 661.3155384177353, 670.6579644381401, 684.4182444921777, 4767.380240568704, 5041.193409054534, 5067.265246539231, 5074.949250507521, 5110.0801855665595, 70363.2963670367, 71728.28271717216, 106750.46624766827, 107773.0, 114365.0, 62673.37326626766, 76163.61918190373, 97093.51453242688, 97559.0, 97992.51003745079, 61545.0, 85282.0, 87713.56143219244, 88184.55907720549, 88428.0, 9228.493569538803, 9349.85975210386, 9478.336516443782, 9517.095875891779, 9518.73150021414, 50589.74705126451, 52230.738846305525, 52502.0, 52650.47349526609, 52838.0, 69833.30166698471, 70169.0, 75737.24262757522, 77696.0, 79748.20251797407, 11392.405063291311, 11519.76960460803, 11663.88336116628, 11991.160618756603, 12113.878861211275, 13807.378667959765, 13813.792793108312, 13884.236366999912, 14101.368236755208, 14192.716145677236, 12672.556460523838, 12688.23870567769, 12712.936435317764, 13146.539980085474, 13246.139000964906, 12646.620601381974, 12846.486140554272, 13126.60620181396, 13143.41856556469, 13248.735025299247, 12523.812142817682, 12875.678108047, 13070.673233169247, 13334.933325333699, 13503.39234734459, 10438.269321147447, 10489.318194317346, 10577.894221057692, 10648.73378165521, 11047.226694131334, 10114.696559103239, 10208.2343824212, 10561.260711750103, 10688.946555267485, 10722.731931701457], "value": 7333.764833519745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 112.0, 112.0, 114.0, 113.0, 112.0, 111.0, 115.0, 111.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 158.0, 183.0, 127.0, 156.0, 160.0, 130.0, 188.0, 128.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 163.0, 170.0, 169.0, 161.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 168.0, 75.0, 75.0, 74.0, 77.0, 165.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 143.0, 84.0, 86.0, 85.0, 138.0, 86.0, 85.0, 142.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 119.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 59.0, 59.0, 65.0, 56.0, 56.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 63.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 81.0, 80.0, 82.0, 81.0, 82.0, 81.0, 102.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 131.0, 133.0, 128.0, 134.0, 132.0, 135.0, 125.0, 126.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 160.0, 164.0, 164.0, 171.0, 162.0, 162.0, 163.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 68.0, 67.0, 64.0, 66.0, 64.0, 63.0], "value": 64.8, "unit": "score"}]}]} 00:11:31 INFO - Return code: 0 00:11:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:11:31 ERROR - # TBPL SUCCESS # 00:11:31 INFO - Running post-action listener: _resource_record_post_action 00:11:31 INFO - ##### 00:11:31 INFO - ##### Finished run-tests step (success) 00:11:31 INFO - ##### 00:11:31 INFO - Running post-run listener: _resource_record_post_run 00:11:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 553488384; Read time: 0; Write time: 501484 00:11:31 INFO - TinderboxPrint: CPU usage
13.5% 00:11:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:11:31 INFO - TinderboxPrint: I/O write bytes / time
553,488,384 / 501,484 00:11:31 INFO - TinderboxPrint: CPU idle
8,216.6 (86.5%) 00:11:31 INFO - TinderboxPrint: CPU user
1,224.1 (12.9%) 00:11:31 INFO - TinderboxPrint: Swap in / out
0 / 0 00:11:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259125248; Read time: 0; Write time: 268756 00:11:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294363136; Read time: 0; Write time: 232728 00:11:32 INFO - Running post-run listener: _upload_blobber_files 00:11:32 INFO - Blob upload gear active. 00:11:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:11:32 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 00:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:11:32 INFO - (blobuploader) - INFO - Open directory for files ... 00:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:33 INFO - (blobuploader) - INFO - Done attempting. 00:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:34 INFO - (blobuploader) - INFO - Done attempting. 00:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:38 INFO - (blobuploader) - INFO - Done attempting. 00:11:38 INFO - (blobuploader) - INFO - Iteration through files over. 00:11:38 INFO - Return code: 0 00:11:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:11:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:11:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa40db41d79e7868189b47c7162d6be2a1c3b2c78b94e1da260072f7d16f12da5389b7dd4350947498d66a96f3f85fab12817e93e5d4186f8c2b186fc33713f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19c230611a809fa70b931886f3804c73a1ad965cfed81f8da0aa3776d0e23e1c95313d9feb38d7ad7dbd4684b6054ed0455ed332b0e4f515155351b37ddda0a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/154c0b8d5716eba5fad9dd60a9d614e22250375a10aa9428c3c0759be6a194b108b10db2c36930db34140c4523ae554657d50188c5eba3900dd3981f5b94f437"} 00:11:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:11:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:11:38 INFO - Contents: 00:11:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa40db41d79e7868189b47c7162d6be2a1c3b2c78b94e1da260072f7d16f12da5389b7dd4350947498d66a96f3f85fab12817e93e5d4186f8c2b186fc33713f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19c230611a809fa70b931886f3804c73a1ad965cfed81f8da0aa3776d0e23e1c95313d9feb38d7ad7dbd4684b6054ed0455ed332b0e4f515155351b37ddda0a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/154c0b8d5716eba5fad9dd60a9d614e22250375a10aa9428c3c0759be6a194b108b10db2c36930db34140c4523ae554657d50188c5eba3900dd3981f5b94f437"} 00:11:38 INFO - Running post-run listener: copy_logs_to_upload_dir 00:11:38 INFO - Copying logs to upload dir... 00:11:38 INFO - mkdir: /builds/slave/test/build/upload/logs 00:11:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.267812 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-09 00:11:37.992856) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:37.996928) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 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/sha512/fa40db41d79e7868189b47c7162d6be2a1c3b2c78b94e1da260072f7d16f12da5389b7dd4350947498d66a96f3f85fab12817e93e5d4186f8c2b186fc33713f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19c230611a809fa70b931886f3804c73a1ad965cfed81f8da0aa3776d0e23e1c95313d9feb38d7ad7dbd4684b6054ed0455ed332b0e4f515155351b37ddda0a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/154c0b8d5716eba5fad9dd60a9d614e22250375a10aa9428c3c0759be6a194b108b10db2c36930db34140c4523ae554657d50188c5eba3900dd3981f5b94f437"} build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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/sha512/fa40db41d79e7868189b47c7162d6be2a1c3b2c78b94e1da260072f7d16f12da5389b7dd4350947498d66a96f3f85fab12817e93e5d4186f8c2b186fc33713f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19c230611a809fa70b931886f3804c73a1ad965cfed81f8da0aa3776d0e23e1c95313d9feb38d7ad7dbd4684b6054ed0455ed332b0e4f515155351b37ddda0a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/154c0b8d5716eba5fad9dd60a9d614e22250375a10aa9428c3c0759be6a194b108b10db2c36930db34140c4523ae554657d50188c5eba3900dd3981f5b94f437"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:38.023019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:38.023436) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1465452580.635095-1589204674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:38.108372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:11:38.108695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:11:38.109004) ========= ========= Total master_lag: 0.18 =========