builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1468959780.92 results: success (0) buildid: 20160719103424 builduid: 9e5d7c40f82e48dcadc7406a14855bb4 revision: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:00.920770) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:00.921341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:00.921632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:00.948946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:00.949353) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 13:23:02-- 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% 40.4M=0s 2016-07-19 13:23:02 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.090220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.090521) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.140639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.140971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e --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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 13:23:02,306 truncating revision to first 12 chars 2016-07-19 13:23:02,306 Setting DEBUG logging. 2016-07-19 13:23:02,306 attempt 1/10 2016-07-19 13:23:02,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/68ca48e7a164?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 13:23:02,782 unpacking tar archive at: mozilla-aurora-68ca48e7a164/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.979038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.979357) ========= script_repo_revision: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.979745) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.980024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 13:23:01.989625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-19 13:23:01.989983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:23:03 INFO - MultiFileLogger online at 20160719 13:23:03 in /builds/slave/test 13:23:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:23:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:23:03 INFO - {'append_to_log': False, 13:23:03 INFO - 'base_work_dir': '/builds/slave/test', 13:23:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:23:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:23:03 INFO - 'branch': 'Mozilla-Aurora', 13:23:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:23:03 INFO - 'config_files': ('talos/linux_config.py',), 13:23:03 INFO - 'default_actions': ('clobber', 13:23:03 INFO - 'read-buildbot-config', 13:23:03 INFO - 'download-and-extract', 13:23:03 INFO - 'populate-webroot', 13:23:03 INFO - 'create-virtualenv', 13:23:03 INFO - 'install', 13:23:03 INFO - 'run-tests'), 13:23:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:23:03 INFO - 'download_minidump_stackwalk': True, 13:23:03 INFO - 'download_symbols': 'ondemand', 13:23:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:23:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:23:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:23:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:23:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:23:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:23:03 INFO - 'installer_path': 'installer.exe', 13:23:03 INFO - 'log_level': 'info', 13:23:03 INFO - 'log_name': 'talos', 13:23:03 INFO - 'log_to_console': True, 13:23:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:23:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:23:03 INFO - 'opt_config_files': (), 13:23:03 INFO - 'pip_index': False, 13:23:03 INFO - 'sps_profile': False, 13:23:03 INFO - 'sps_profile_interval': 0, 13:23:03 INFO - 'suite': 'dromaeojs', 13:23:03 INFO - 'system_bits': '32', 13:23:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:23:03 INFO - 'title': 'talos-linux64-ix-068', 13:23:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:23:03 INFO - 'use_talos_json': True, 13:23:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:23:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:23:03 INFO - 'work_dir': 'build'} 13:23:03 INFO - ##### 13:23:03 INFO - ##### Running clobber step. 13:23:03 INFO - ##### 13:23:03 INFO - Running pre-action listener: _resource_record_pre_action 13:23:03 INFO - Running main action method: clobber 13:23:03 INFO - rmtree: /builds/slave/test/build 13:23:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:23:03 INFO - Running post-action listener: _resource_record_post_action 13:23:03 INFO - ##### 13:23:03 INFO - ##### Finished clobber step (success) 13:23:03 INFO - ##### 13:23:03 INFO - ##### 13:23:03 INFO - ##### Running read-buildbot-config step. 13:23:03 INFO - ##### 13:23:03 INFO - Running pre-action listener: _resource_record_pre_action 13:23:03 INFO - Running main action method: read_buildbot_config 13:23:03 INFO - Using buildbot properties: 13:23:03 INFO - { 13:23:03 INFO - "project": "", 13:23:03 INFO - "product": "firefox", 13:23:03 INFO - "script_repo_revision": "production", 13:23:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:23:03 INFO - "repository": "", 13:23:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:23:03 INFO - "buildid": "20160719103424", 13:23:03 INFO - "pgo_build": "True", 13:23:03 INFO - "basedir": "/builds/slave/test", 13:23:03 INFO - "buildnumber": 374, 13:23:03 INFO - "slavename": "talos-linux64-ix-068", 13:23:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:23:03 INFO - "platform": "ubuntu64_hw", 13:23:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:23:03 INFO - "branch": "mozilla-aurora", 13:23:03 INFO - "repo_path": "releases/mozilla-aurora", 13:23:03 INFO - "revision": "68ca48e7a1646a4e43f1c11393c92de0fc52bb3e", 13:23:03 INFO - "stage_platform": "linux64-pgo", 13:23:03 INFO - "builduid": "9e5d7c40f82e48dcadc7406a14855bb4", 13:23:03 INFO - "slavebuilddir": "test" 13:23:03 INFO - } 13:23:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 13:23:03 INFO - Running post-action listener: _resource_record_post_action 13:23:03 INFO - ##### 13:23:03 INFO - ##### Finished read-buildbot-config step (success) 13:23:03 INFO - ##### 13:23:03 INFO - ##### 13:23:03 INFO - ##### Running download-and-extract step. 13:23:03 INFO - ##### 13:23:03 INFO - Running pre-action listener: _resource_record_pre_action 13:23:03 INFO - Running main action method: download_and_extract 13:23:03 INFO - mkdir: /builds/slave/test/build/tests 13:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:03 INFO - https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:23:05 INFO - Downloaded 1361 bytes. 13:23:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:23:05 INFO - Using the following test package requirements: 13:23:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:23:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:23:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:23:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'jsshell-linux-x86_64.zip'], 13:23:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:23:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:23:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:23:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:23:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:23:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:23:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:05 INFO - https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:23:15 INFO - Downloaded 24489767 bytes. 13:23:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:23:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:23:17 INFO - Return code: 0 13:23:17 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:23:17 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')]} 13:23:17 INFO - https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:23:18 INFO - Downloaded 24489767 bytes. 13:23:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:23:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:23:19 INFO - Return code: 0 13:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:19 INFO - https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:23:20 INFO - Downloaded 10833369 bytes. 13:23:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:23:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:23:20 INFO - Return code: 0 13:23:20 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')]} 13:23:20 INFO - https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:23:22 INFO - Downloaded 63647912 bytes. 13:23:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:23:22 INFO - mkdir: /builds/slave/test/properties 13:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 13:23:22 INFO - Contents: 13:23:22 INFO - build_url:https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:23:23 INFO - Running post-action listener: _resource_record_post_action 13:23:23 INFO - Running post-action listener: set_extra_try_arguments 13:23:23 INFO - ##### 13:23:23 INFO - ##### Finished download-and-extract step (success) 13:23:23 INFO - ##### 13:23:23 INFO - ##### 13:23:23 INFO - ##### Running populate-webroot step. 13:23:23 INFO - ##### 13:23:23 INFO - Running pre-action listener: _resource_record_pre_action 13:23:23 INFO - Running main action method: populate_webroot 13:23:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:23:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:23:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:23:23 INFO - '--tppagecycles', 13:23:23 INFO - '7'], 13:23:23 INFO - 'tests': ['tsvgm']}}, 13:23:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:23:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:23:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:23:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:23:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['damp', 'tps']}, 13:23:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'tests': ['damp', 'tps']}, 13:23:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['dromaeo_dom']}, 13:23:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:23:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['a11yr', 13:23:23 INFO - 'ts_paint', 13:23:23 INFO - 'tpaint', 13:23:23 INFO - 'sessionrestore', 13:23:23 INFO - 'sessionrestore_no_auto_restore', 13:23:23 INFO - 'tabpaint']}, 13:23:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['tsvgx', 13:23:23 INFO - 'tsvgr_opacity', 13:23:23 INFO - 'tart', 13:23:23 INFO - 'tscrollx', 13:23:23 INFO - 'cart']}, 13:23:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:23:23 INFO - 'tsvgr_opacity', 13:23:23 INFO - 'tart', 13:23:23 INFO - 'tscrollx', 13:23:23 INFO - 'cart']}, 13:23:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'talos_options': ['--disable-e10s'], 13:23:23 INFO - 'tests': ['tp5o']}, 13:23:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'tests': ['tp5o']}, 13:23:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'talos_options': ['--disable-e10s', 13:23:23 INFO - '--xperf_path', 13:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:23 INFO - 'tests': ['tp5n']}, 13:23:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:23 INFO - 'talos_options': ['--xperf_path', 13:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:23 INFO - 'tests': ['tp5n']}}, 13:23:23 INFO - 'talos.zip': {'path': '', 13:23:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:23:23 INFO - Running post-action listener: _resource_record_post_action 13:23:23 INFO - ##### 13:23:23 INFO - ##### Finished populate-webroot step (success) 13:23:23 INFO - ##### 13:23:23 INFO - ##### 13:23:23 INFO - ##### Running create-virtualenv step. 13:23:23 INFO - ##### 13:23:23 INFO - Running pre-action listener: _resource_record_pre_action 13:23:23 INFO - Running main action method: create_virtualenv 13:23:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:23:23 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 13:23:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:23:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:23:23 INFO - Using real prefix '/usr' 13:23:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:23:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:23:25 INFO - Installing pip.................done. 13:23:25 INFO - Return code: 0 13:23:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:23:25 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')]} 13:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 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')]} 13:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:25 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 13:23:25 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 13:23:25 INFO - Using env: {'DISPLAY': ':0', 13:23:25 INFO - 'HOME': '/home/cltbld', 13:23:25 INFO - 'LANG': 'en_US.UTF-8', 13:23:25 INFO - 'LANGUAGE': 'en_US:en', 13:23:25 INFO - 'LOGNAME': 'cltbld', 13:23:25 INFO - 'MAIL': '/var/mail/cltbld', 13:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:25 INFO - 'MOZ_NO_REMOTE': '1', 13:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:25 INFO - 'NO_EM_RESTART': '1', 13:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:25 INFO - 'PWD': '/builds/slave/test', 13:23:25 INFO - 'SHELL': '/bin/bash', 13:23:25 INFO - 'SHLVL': '1', 13:23:25 INFO - 'TERM': 'linux', 13:23:25 INFO - 'TMOUT': '86400', 13:23:25 INFO - 'USER': 'cltbld', 13:23:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:25 INFO - '_': '/tools/buildbot/bin/python'} 13:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:25 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 13:23:25 INFO - Cleaning up... 13:23:25 INFO - Return code: 0 13:23:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:23:25 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')]} 13:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 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')]} 13:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:25 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:25 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 13:23:25 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 13:23:25 INFO - Using env: {'DISPLAY': ':0', 13:23:25 INFO - 'HOME': '/home/cltbld', 13:23:25 INFO - 'LANG': 'en_US.UTF-8', 13:23:25 INFO - 'LANGUAGE': 'en_US:en', 13:23:25 INFO - 'LOGNAME': 'cltbld', 13:23:25 INFO - 'MAIL': '/var/mail/cltbld', 13:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:25 INFO - 'MOZ_NO_REMOTE': '1', 13:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:25 INFO - 'NO_EM_RESTART': '1', 13:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:25 INFO - 'PWD': '/builds/slave/test', 13:23:25 INFO - 'SHELL': '/bin/bash', 13:23:25 INFO - 'SHLVL': '1', 13:23:25 INFO - 'TERM': 'linux', 13:23:25 INFO - 'TMOUT': '86400', 13:23:25 INFO - 'USER': 'cltbld', 13:23:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:25 INFO - '_': '/tools/buildbot/bin/python'} 13:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:26 INFO - Downloading/unpacking psutil>=3.1.1 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:28 INFO - Installing collected packages: psutil 13:23:28 INFO - Running setup.py install for psutil 13:23:28 INFO - building 'psutil._psutil_linux' extension 13:23:28 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 13:23:28 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 13:23:28 INFO - building 'psutil._psutil_posix' extension 13:23:28 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 13:23:28 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 13:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:28 INFO - Successfully installed psutil 13:23:28 INFO - Cleaning up... 13:23:28 INFO - Return code: 0 13:23:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23:28 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')]} 13:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:28 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')]} 13:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:28 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:28 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 13:23:28 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 13:23:28 INFO - Using env: {'DISPLAY': ':0', 13:23:28 INFO - 'HOME': '/home/cltbld', 13:23:28 INFO - 'LANG': 'en_US.UTF-8', 13:23:28 INFO - 'LANGUAGE': 'en_US:en', 13:23:28 INFO - 'LOGNAME': 'cltbld', 13:23:28 INFO - 'MAIL': '/var/mail/cltbld', 13:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:28 INFO - 'MOZ_NO_REMOTE': '1', 13:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:28 INFO - 'NO_EM_RESTART': '1', 13:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:28 INFO - 'PWD': '/builds/slave/test', 13:23:28 INFO - 'SHELL': '/bin/bash', 13:23:28 INFO - 'SHLVL': '1', 13:23:28 INFO - 'TERM': 'linux', 13:23:28 INFO - 'TMOUT': '86400', 13:23:28 INFO - 'USER': 'cltbld', 13:23:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:28 INFO - '_': '/tools/buildbot/bin/python'} 13:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:30 INFO - Installing collected packages: mozsystemmonitor 13:23:30 INFO - Running setup.py install for mozsystemmonitor 13:23:30 INFO - Successfully installed mozsystemmonitor 13:23:30 INFO - Cleaning up... 13:23:31 INFO - Return code: 0 13:23:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:23:31 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')]} 13:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:31 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')]} 13:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:31 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:31 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 13:23:31 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 13:23:31 INFO - Using env: {'DISPLAY': ':0', 13:23:31 INFO - 'HOME': '/home/cltbld', 13:23:31 INFO - 'LANG': 'en_US.UTF-8', 13:23:31 INFO - 'LANGUAGE': 'en_US:en', 13:23:31 INFO - 'LOGNAME': 'cltbld', 13:23:31 INFO - 'MAIL': '/var/mail/cltbld', 13:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:31 INFO - 'MOZ_NO_REMOTE': '1', 13:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:31 INFO - 'NO_EM_RESTART': '1', 13:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:31 INFO - 'PWD': '/builds/slave/test', 13:23:31 INFO - 'SHELL': '/bin/bash', 13:23:31 INFO - 'SHLVL': '1', 13:23:31 INFO - 'TERM': 'linux', 13:23:31 INFO - 'TMOUT': '86400', 13:23:31 INFO - 'USER': 'cltbld', 13:23:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:31 INFO - '_': '/tools/buildbot/bin/python'} 13:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:23:31 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 13:23:31 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 13:23:31 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 13:23:31 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 13:23:31 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 13:23:31 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 13:23:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:33 INFO - warning: no files found matching '*.txt' 13:23:33 INFO - no previously-included directories found matching 'build' 13:23:33 INFO - no previously-included directories found matching 'dist' 13:23:33 INFO - no previously-included directories found matching '.git*' 13:23:33 INFO - Installing collected packages: jsonschema, functools32 13:23:33 INFO - Running setup.py install for functools32 13:23:33 INFO - warning: no files found matching '*.txt' 13:23:33 INFO - no previously-included directories found matching 'build' 13:23:33 INFO - no previously-included directories found matching 'dist' 13:23:33 INFO - no previously-included directories found matching '.git*' 13:23:33 INFO - Successfully installed jsonschema functools32 13:23:33 INFO - Cleaning up... 13:23:33 INFO - Return code: 0 13:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:23:33 INFO - Using env: {'DISPLAY': ':0', 13:23:33 INFO - 'HOME': '/home/cltbld', 13:23:33 INFO - 'LANG': 'en_US.UTF-8', 13:23:33 INFO - 'LANGUAGE': 'en_US:en', 13:23:33 INFO - 'LOGNAME': 'cltbld', 13:23:33 INFO - 'MAIL': '/var/mail/cltbld', 13:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:33 INFO - 'MOZ_NO_REMOTE': '1', 13:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:33 INFO - 'NO_EM_RESTART': '1', 13:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:33 INFO - 'PWD': '/builds/slave/test', 13:23:33 INFO - 'SHELL': '/bin/bash', 13:23:33 INFO - 'SHLVL': '1', 13:23:33 INFO - 'TERM': 'linux', 13:23:33 INFO - 'TMOUT': '86400', 13:23:33 INFO - 'USER': 'cltbld', 13:23:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:33 INFO - '_': '/tools/buildbot/bin/python'} 13:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:33 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 13:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:35 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 13:23:35 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 13:23:35 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 13:23:35 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 13:23:35 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 13:23:35 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 13:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:36 INFO - Downloading docopt-0.6.1.tar.gz 13:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:36 INFO - Running setup.py install for blobuploader 13:23:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:36 INFO - Running setup.py install for requests 13:23:36 INFO - Running setup.py install for docopt 13:23:37 INFO - Successfully installed blobuploader requests docopt 13:23:37 INFO - Cleaning up... 13:23:37 INFO - Return code: 0 13:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:37 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:37 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 13:23:37 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 13:23:37 INFO - Using env: {'DISPLAY': ':0', 13:23:37 INFO - 'HOME': '/home/cltbld', 13:23:37 INFO - 'LANG': 'en_US.UTF-8', 13:23:37 INFO - 'LANGUAGE': 'en_US:en', 13:23:37 INFO - 'LOGNAME': 'cltbld', 13:23:37 INFO - 'MAIL': '/var/mail/cltbld', 13:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:37 INFO - 'MOZ_NO_REMOTE': '1', 13:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:37 INFO - 'NO_EM_RESTART': '1', 13:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:37 INFO - 'PWD': '/builds/slave/test', 13:23:37 INFO - 'SHELL': '/bin/bash', 13:23:37 INFO - 'SHLVL': '1', 13:23:37 INFO - 'TERM': 'linux', 13:23:37 INFO - 'TMOUT': '86400', 13:23:37 INFO - 'USER': 'cltbld', 13:23:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:37 INFO - '_': '/tools/buildbot/bin/python'} 13:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:37 INFO - Running setup.py (path:/tmp/pip-TEJM_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:37 INFO - Running setup.py (path:/tmp/pip-Si7w35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:37 INFO - Running setup.py (path:/tmp/pip-eA0SO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:37 INFO - Running setup.py (path:/tmp/pip-F49EA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:37 INFO - Running setup.py (path:/tmp/pip-t4NSiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:37 INFO - Running setup.py (path:/tmp/pip-nL4hDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:37 INFO - Running setup.py (path:/tmp/pip-D2qGFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:37 INFO - Running setup.py (path:/tmp/pip-LR01Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:37 INFO - Running setup.py (path:/tmp/pip-jNWAxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:38 INFO - Running setup.py (path:/tmp/pip-NFnBKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:38 INFO - Running setup.py (path:/tmp/pip-WlC958-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:38 INFO - Running setup.py (path:/tmp/pip-sYYOfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:38 INFO - Running setup.py (path:/tmp/pip-Wp7A1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:38 INFO - Running setup.py (path:/tmp/pip-ZcjCNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:38 INFO - Running setup.py (path:/tmp/pip-Hg6nJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:38 INFO - Running setup.py (path:/tmp/pip-0fXLaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:38 INFO - Running setup.py (path:/tmp/pip-9cUloU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:38 INFO - Running setup.py install for manifestparser 13:23:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:38 INFO - Running setup.py install for mozcrash 13:23:38 INFO - Running setup.py install for mozdebug 13:23:38 INFO - Running setup.py install for mozdevice 13:23:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozfile 13:23:39 INFO - Running setup.py install for mozhttpd 13:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozinfo 13:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozInstall 13:23:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozleak 13:23:39 INFO - Running setup.py install for mozlog 13:23:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for moznetwork 13:23:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozprocess 13:23:39 INFO - Running setup.py install for mozprofile 13:23:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:39 INFO - Running setup.py install for mozrunner 13:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:40 INFO - Running setup.py install for mozscreenshot 13:23:40 INFO - Running setup.py install for moztest 13:23:40 INFO - Running setup.py install for mozversion 13:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:40 INFO - Cleaning up... 13:23:40 INFO - Return code: 0 13:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:40 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:40 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 13:23:40 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 13:23:40 INFO - Using env: {'DISPLAY': ':0', 13:23:40 INFO - 'HOME': '/home/cltbld', 13:23:40 INFO - 'LANG': 'en_US.UTF-8', 13:23:40 INFO - 'LANGUAGE': 'en_US:en', 13:23:40 INFO - 'LOGNAME': 'cltbld', 13:23:40 INFO - 'MAIL': '/var/mail/cltbld', 13:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:40 INFO - 'MOZ_NO_REMOTE': '1', 13:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:40 INFO - 'NO_EM_RESTART': '1', 13:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:40 INFO - 'PWD': '/builds/slave/test', 13:23:40 INFO - 'SHELL': '/bin/bash', 13:23:40 INFO - 'SHLVL': '1', 13:23:40 INFO - 'TERM': 'linux', 13:23:40 INFO - 'TMOUT': '86400', 13:23:40 INFO - 'USER': 'cltbld', 13:23:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:40 INFO - '_': '/tools/buildbot/bin/python'} 13:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:40 INFO - Running setup.py (path:/tmp/pip-mxPD4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:40 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)) 13:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:40 INFO - Running setup.py (path:/tmp/pip-KIG3fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:40 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)) 13:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:40 INFO - Running setup.py (path:/tmp/pip-I7tCAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:40 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)) 13:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:40 INFO - Running setup.py (path:/tmp/pip-AB2kzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:40 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)) 13:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:40 INFO - Running setup.py (path:/tmp/pip-sZgBKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:41 INFO - Running setup.py (path:/tmp/pip-_rGhWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:41 INFO - Running setup.py (path:/tmp/pip-Fdq77n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:41 INFO - Running setup.py (path:/tmp/pip-YXNcoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:41 INFO - Running setup.py (path:/tmp/pip-da9CTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:41 INFO - Running setup.py (path:/tmp/pip-lrcJXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:41 INFO - Running setup.py (path:/tmp/pip-Go5ABD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:41 INFO - Running setup.py (path:/tmp/pip-jHirmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:41 INFO - Running setup.py (path:/tmp/pip-2B8epn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:41 INFO - Running setup.py (path:/tmp/pip-MRL2RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:41 INFO - Running setup.py (path:/tmp/pip-vqnFZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:41 INFO - Running setup.py (path:/tmp/pip-NG1l1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:41 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)) 13:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:41 INFO - Running setup.py (path:/tmp/pip-FA0knN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:41 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)) 13:23:41 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)) 13:23:41 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)) 13:23:41 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)) 13:23:41 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)) 13:23:41 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)) 13:23:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:43 INFO - Downloading blessings-1.6.tar.gz 13:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:43 INFO - Installing collected packages: blessings 13:23:43 INFO - Running setup.py install for blessings 13:23:43 INFO - Successfully installed blessings 13:23:43 INFO - Cleaning up... 13:23:44 INFO - Return code: 0 13:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:44 INFO - Reading from file tmpfile_stdout 13:23:44 INFO - Current package versions: 13:23:44 INFO - argparse == 1.2.1 13:23:44 INFO - blessings == 1.6 13:23:44 INFO - blobuploader == 1.2.4 13:23:44 INFO - docopt == 0.6.1 13:23:44 INFO - functools32 == 3.2.3-2 13:23:44 INFO - jsonschema == 2.5.1 13:23:44 INFO - manifestparser == 1.1 13:23:44 INFO - mozInstall == 1.12 13:23:44 INFO - mozcrash == 0.17 13:23:44 INFO - mozdebug == 0.1 13:23:44 INFO - mozdevice == 0.48 13:23:44 INFO - mozfile == 1.2 13:23:44 INFO - mozhttpd == 0.7 13:23:44 INFO - mozinfo == 0.9 13:23:44 INFO - mozleak == 0.1 13:23:44 INFO - mozlog == 3.2 13:23:44 INFO - moznetwork == 0.27 13:23:44 INFO - mozprocess == 0.23 13:23:44 INFO - mozprofile == 0.28 13:23:44 INFO - mozrunner == 6.12 13:23:44 INFO - mozscreenshot == 0.1 13:23:44 INFO - mozsystemmonitor == 0.3 13:23:44 INFO - moztest == 0.7 13:23:44 INFO - mozversion == 1.4 13:23:44 INFO - psutil == 3.1.1 13:23:44 INFO - requests == 1.2.3 13:23:44 INFO - wsgiref == 0.1.2 13:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 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 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:44 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 13:23:44 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 13:23:44 INFO - Using env: {'DISPLAY': ':0', 13:23:44 INFO - 'HOME': '/home/cltbld', 13:23:44 INFO - 'LANG': 'en_US.UTF-8', 13:23:44 INFO - 'LANGUAGE': 'en_US:en', 13:23:44 INFO - 'LOGNAME': 'cltbld', 13:23:44 INFO - 'MAIL': '/var/mail/cltbld', 13:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:44 INFO - 'MOZ_NO_REMOTE': '1', 13:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:44 INFO - 'NO_EM_RESTART': '1', 13:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:44 INFO - 'PWD': '/builds/slave/test', 13:23:44 INFO - 'SHELL': '/bin/bash', 13:23:44 INFO - 'SHLVL': '1', 13:23:44 INFO - 'TERM': 'linux', 13:23:44 INFO - 'TMOUT': '86400', 13:23:44 INFO - 'USER': 'cltbld', 13:23:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:44 INFO - '_': '/tools/buildbot/bin/python'} 13:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 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)) 13:23:44 INFO - Cleaning up... 13:23:44 INFO - Return code: 0 13:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:23:44 INFO - Using env: {'DISPLAY': ':0', 13:23:44 INFO - 'HOME': '/home/cltbld', 13:23:44 INFO - 'LANG': 'en_US.UTF-8', 13:23:44 INFO - 'LANGUAGE': 'en_US:en', 13:23:44 INFO - 'LOGNAME': 'cltbld', 13:23:44 INFO - 'MAIL': '/var/mail/cltbld', 13:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:44 INFO - 'MOZ_NO_REMOTE': '1', 13:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:44 INFO - 'NO_EM_RESTART': '1', 13:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:44 INFO - 'PWD': '/builds/slave/test', 13:23:44 INFO - 'SHELL': '/bin/bash', 13:23:44 INFO - 'SHLVL': '1', 13:23:44 INFO - 'TERM': 'linux', 13:23:44 INFO - 'TMOUT': '86400', 13:23:44 INFO - 'USER': 'cltbld', 13:23:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:44 INFO - '_': '/tools/buildbot/bin/python'} 13:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:23:44 INFO - Cleaning up... 13:23:44 INFO - Return code: 0 13:23:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f074072bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', '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 13:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:23:44 INFO - Using env: {'DISPLAY': ':0', 13:23:44 INFO - 'HOME': '/home/cltbld', 13:23:44 INFO - 'LANG': 'en_US.UTF-8', 13:23:44 INFO - 'LANGUAGE': 'en_US:en', 13:23:44 INFO - 'LOGNAME': 'cltbld', 13:23:44 INFO - 'MAIL': '/var/mail/cltbld', 13:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:44 INFO - 'MOZ_NO_REMOTE': '1', 13:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:44 INFO - 'NO_EM_RESTART': '1', 13:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:44 INFO - 'PWD': '/builds/slave/test', 13:23:44 INFO - 'SHELL': '/bin/bash', 13:23:44 INFO - 'SHLVL': '1', 13:23:44 INFO - 'TERM': 'linux', 13:23:44 INFO - 'TMOUT': '86400', 13:23:44 INFO - 'USER': 'cltbld', 13:23:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:44 INFO - '_': '/tools/buildbot/bin/python'} 13:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:44 INFO - Downloading/unpacking flake8 13:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:46 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 13:23:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:47 INFO - no previously-included directories found matching 'docs/_build' 13:23:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:47 INFO - Running setup.py install for pep8 13:23:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:47 INFO - no previously-included directories found matching 'docs/_build' 13:23:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:47 INFO - Cleaning up... 13:23:47 INFO - Return code: 0 13:23:47 INFO - Running post-action listener: _resource_record_post_action 13:23:47 INFO - Running post-action listener: _start_resource_monitoring 13:23:47 INFO - Starting resource monitoring. 13:23:47 INFO - ##### 13:23:47 INFO - ##### Finished create-virtualenv step (success) 13:23:47 INFO - ##### 13:23:47 INFO - ##### 13:23:47 INFO - ##### Running install step. 13:23:47 INFO - ##### 13:23:47 INFO - Running pre-action listener: _resource_record_pre_action 13:23:47 INFO - Running main action method: install 13:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:48 INFO - Reading from file tmpfile_stdout 13:23:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:48 INFO - Reading from file tmpfile_stdout 13:23:48 INFO - Output received: 13:23:48 INFO - Usage: mozinstall [options] installer 13:23:48 INFO - Options: 13:23:48 INFO - -h, --help show this help message and exit 13:23:48 INFO - -d DEST, --destination=DEST 13:23:48 INFO - Directory to install application into. [default: 13:23:48 INFO - "/builds/slave/test"] 13:23:48 INFO - --app=APP Application being installed. [default: firefox] 13:23:48 INFO - mkdir: /builds/slave/test/build/application 13:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:24:04 INFO - Reading from file tmpfile_stdout 13:24:04 INFO - Output received: 13:24:04 INFO - /builds/slave/test/build/application/firefox/firefox 13:24:04 INFO - Running post-action listener: _resource_record_post_action 13:24:04 INFO - ##### 13:24:04 INFO - ##### Finished install step (success) 13:24:04 INFO - ##### 13:24:04 INFO - ##### 13:24:04 INFO - ##### Running run-tests step. 13:24:04 INFO - ##### 13:24:04 INFO - Running pre-action listener: _resource_record_pre_action 13:24:04 INFO - Running main action method: run_tests 13:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:24:04 INFO - Python 2.7.3 13:24:04 INFO - Return code: 0 13:24:04 INFO - grabbing minidump binary from tooltool 13:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:04 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 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:24:04 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 13:24:04 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 13:24:04 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 13:24:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:24:04 INFO - Return code: 0 13:24:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:24:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:24:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:24:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:24:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:24:05 INFO - Return code: 0 13:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:24:05 INFO - Using env: {'DISPLAY': ':0', 13:24:05 INFO - 'HOME': '/home/cltbld', 13:24:05 INFO - 'LANG': 'en_US.UTF-8', 13:24:05 INFO - 'LANGUAGE': 'en_US:en', 13:24:05 INFO - 'LOGNAME': 'cltbld', 13:24:05 INFO - 'MAIL': '/var/mail/cltbld', 13:24:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:24:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:05 INFO - 'MOZ_NO_REMOTE': '1', 13:24:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:24:05 INFO - 'NO_EM_RESTART': '1', 13:24:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:05 INFO - 'PWD': '/builds/slave/test', 13:24:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:24:05 INFO - 'SHELL': '/bin/bash', 13:24:05 INFO - 'SHLVL': '1', 13:24:05 INFO - 'TERM': 'linux', 13:24:05 INFO - 'TMOUT': '86400', 13:24:05 INFO - 'USER': 'cltbld', 13:24:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809', 13:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:05 INFO - '_': '/tools/buildbot/bin/python'} 13:24:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:24:05 INFO - mozversion application_buildid: 20160719103424 13:24:05 INFO - mozversion application_changeset: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e 13:24:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:24:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:24:05 INFO - mozversion application_name: Firefox 13:24:05 INFO - mozversion application_remotingname: firefox-dev 13:24:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:24:05 INFO - mozversion application_vendor: Mozilla 13:24:05 INFO - mozversion application_version: 49.0a2 13:24:05 INFO - mozversion platform_buildid: 20160719103424 13:24:05 INFO - mozversion platform_changeset: 68ca48e7a1646a4e43f1c11393c92de0fc52bb3e 13:24:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:24:05 INFO - mozversion platform_version: 49.0a2 13:24:05 INFO - using testdate: 1468959845 13:24:05 INFO - actual date: 1468959845 13:24:05 INFO - starting webserver on 'localhost:44135' 13:24:05 INFO - SUITE-START | Running 2 tests 13:24:05 INFO - TEST-START | dromaeo_css 13:24:05 INFO - operating with platform_type : linux_ 13:24:05 INFO - Initialising browser for dromaeo_css test... 13:24:05 INFO - TEST-INFO | started process 24986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYawsUp/profile http://localhost:44135/getInfo.html) 13:24:09 INFO - PROCESS | 24986 | __metrics Screen width/height:1600/1200 13:24:09 INFO - PROCESS | 24986 | colorDepth:24 13:24:09 INFO - PROCESS | 24986 | Browser inner width/height: 1024/697 13:24:09 INFO - PROCESS | 24986 | __metrics 13:24:10 INFO - PROCESS | 24986 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:24:10 ERROR - PROCESS | 24986 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:24:11 INFO - TEST-INFO | 24986: exit 0 13:24:11 INFO - Browser initialized. 13:24:11 INFO - Running cycle 1/1 for dromaeo_css test... 13:24:11 INFO - TEST-INFO | started process 25079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYawsUp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:23 INFO - PROCESS | 25079 | RSS: Main: 145739776 13:24:23 INFO - PROCESS | 25079 | 13:25:14 INFO - PROCESS | 25079 | 1468959914402 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] 13:27:22 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44135/tests/dromaeo/cssquery-ext.html) 13:27:23 INFO - PROCESS | 25079 | RSS: Main: 246689792 13:27:23 INFO - PROCESS | 25079 | 13:30:26 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-ext.html (next: http://localhost:44135/tests/dromaeo/cssquery-jquery.html) 13:30:26 INFO - PROCESS | 25079 | RSS: Main: 231809024 13:30:26 INFO - PROCESS | 25079 | 13:33:28 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44135/tests/dromaeo/cssquery-mootools.html) 13:33:29 INFO - PROCESS | 25079 | RSS: Main: 222715904 13:33:29 INFO - PROCESS | 25079 | 13:36:30 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44135/tests/dromaeo/cssquery-prototype.html) 13:36:31 INFO - PROCESS | 25079 | RSS: Main: 219484160 13:36:31 INFO - PROCESS | 25079 | 13:39:34 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44135/tests/dromaeo/cssquery-yui.html) 13:39:34 INFO - PROCESS | 25079 | RSS: Main: 217145344 13:39:34 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | Cycle 1(1): loaded http://localhost:44135/tests/dromaeo/cssquery-yui.html (next: http://localhost:44135/tests/dromaeo/cssquery-dojo.html) 13:42:37 INFO - PROCESS | 25079 | RSS: Main: 256081920 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | __start_tp_report 13:42:37 INFO - PROCESS | 25079 | _x_x_mozilla_page_load 13:42:37 INFO - PROCESS | 25079 | _x_x_mozilla_page_load_details 13:42:37 INFO - PROCESS | 25079 | |i|pagename|runs| 13:42:37 INFO - PROCESS | 25079 | |0;dojo.html;3301.7193538549222;3329.966700332996;3344.498325251213;3369.174552234703;3385.153711572107;5371.623986320959;5460.699661518614;5463.098588732854;5474.835754927349;5493.587980901433;5428.701421421821;5461.5357694595905;5461.890762184754;5465.098258787305;5504.339479262494;4833;4920.384951881015;4933.777979990909;4971.080350135218;5043.798248070073;4791.736454495001;4921.655484116113;4959.628027897904;4964.255361695738;4977.825776097838;4825.638077144211;4883.169861123618;4927.408710954691;4940.481249468808;4951.455339912607;5004.099262132815;5032.4967503249745;5034.974825125851;5035.62232832539;5061.1143049966295;4745.620350371962;4886.584640305578;4936.901261974776;4963.45402005779;4996.725180115092;5178.40448348441;5182.352205974254;5204.739763011834;5239.659422137587;5240.371155461331;5693.459121383462;5730.36965933747;5738.655680659173;5744.511716504102;5771.59598828078;5773.971130144364;5800.9709951450395;5849.181114643953;5868.4424979626865;5904.675242861641;5496.203050557687;5520.365158006881;5536.584756143306;5538.612297139242;5542.362628297717;5787.826365209051;6027.487663548647;6036.124761909498;6038.969805150946;6046.969765151146;5658.7170641467765;5682.943170568324;5699.772009119672;5768.596198266081;5786.739596718157;5826.766929322865;5826.970865145647;5844.26946631671;5862.237909071793;5874.383189765099;5624.887502249932;5659.43405659439;5778.855528611818;5785.884282314414;5802.796902108406;5621.831345059655;5692.6299790513485;5695.373508914016;5715.228444159985;5750.079987202028;4426.18115648606;4437.755923424243;4444.933326000112;4450.043240703264;4469.642428605704;3956.564777874489;3989.501312335958;3989.940150897739;4012.6789856811383;4026.617471340218;5569.248151499577;5578.163275508625;5603.131514615241;5604.523615492729;5631.18347839561;5844.006518891713;5845.181674565564;5850.795222167289;5851.414858514199;5884.764609415575;5350.438203988603;5520.199571062254;5567.164925261243;5575.358833734092;5586.832395028075;5071.873203169876;5089.440161582223;5094.108531007133;5096.261042148868;5116.360454943132;6068.089786532056;6090.451859332593;6097.634141951497;6102.931986902275;6111.602745821508;5553.4724201200825;5623.550115990629;5752.654840709571;5772.047612144117;5785.247917770663;6076.1493390924425;6077.118817771487;6082.300535438481;6084.39156084388;6102.267727872683;5677.318721753416;5722.484976352148;5723.570732195185;5728.198052272602;5735.627184233012;5637.915431268616;5703.543716502587;5778.739956702043;5781.248437703071;5804.187413762161;5647.830565083054;5657.971710141423;5661.745221465127;5663.263775709132;5671.801486947937;5608.85977850557;5658.377578466448;5670.291213598301;5677.5457963362005;5691.8292451226525;5457.154141107976;5458.426865179099;5495.697736624524;5501.14732216507;5532.612717109924;5641.464060914206;5696.629719068247;5700.201971723879;5704.201411802268;5704.657720536781;5436.266104075899;5531.640443371168;5566.610337276352;5582.078956972054;5589.636673616202 13:42:37 INFO - PROCESS | 25079 | |1;ext.html;602.3675141101842;634.2674211285965;637.2003136064236;644.6744394080988;657.0964923230558;37068.443973340385;48496.51503484964;48898.75550622242;49233.50766492334;52432;50118.74940625301;50571.241431378556;50734;50738.492615073934;50777.49222507774;8334.70828521002;9107.772305692377;9287.164155226028;10900.945495272552;11192.048675862521;11036.448177591128;11139.888601113966;11148.777024459507;11149.7212569686;11156.776864462707;11159.888401116006;11218.775624487505;11219.102471802236;11223.102151827876;11228.775424491505;8477.788055298635;11079.778404431867;11341.829872551918;11357.204995650307;11362.772744545146;10794.190435717353;10864.239503234776;10874.782504349869;11211.831822522669;11217.326960382321;46312.76843615794;46646.300305495446;46793.76603116962;46818;46896.53103468956;3855;3901.336772748611;3904.4728961590104;4359.302511598161;4384.079343337903;35198.64801352005;35377;36113.81943090294;36301.09247268813;37097.62902370969;4793.784279707422;4833.734144622044;4859.902801943941;4921.926171107436;5002.074616196015;399513;404010;404461;405347;405695;39348;40384.59615403867;69349.30650693529;69900.6504967482;70101.2989870105;42037.159256814695;42343;42467;42500.78749606232;42502;16365.91817040931;17792.199351028976;17927.641447171245;17942;17998.1000949952;14335.426582936565;14602.269886505632;14610.123392596479;14947.925260373846;14968.251587420586;9439.764005899908;9445.102715242041;9504.097110774464;9517.143457088896;9540.475273859865;3589.9102522437147;3616.4213725803747;3646.6717995380545;3696.482492451059;3737.3085979093953;1075.381655548063;1116.1238427834112;1137.5475432063647;1179.5399794080315;1253.022642338977;35239.647603523634;35707;35746.10634734153;35827.82086089553;36131.277374452366;1167.8890505401973;1212.0788200967152;1225.993870030662;1254.5859866244118;1311.5081844308384;17932.820671793375;18702.251909923452;18742.344017959305;18749.531261718566;18854.434366969013;589575;593887;594354;595004;596173;66544.33455665478;67108.3289167102;67187.66406167937;67298.32701673018;67372.32627673661;1334.5595953335376;1469.7060587882465;1470.6985068061022;1493.5220729366715;1516.5298757385026;35049.8247508771;36480.452793207594;36914.44628330631;37146.8142659285;37227.62772372241;56955.71522142363;57345.42654573401;57591.712041439525;57687.71156144192;57732;377286;377662;378132;381812;384552;27933;31282.21794455157;31817.522737159423;32054.19864503406;32280.192995175308;52666;53105;53523.46476535185;54499;54989.72505137449;42918;45969.77015114903;46717.2992405121;47201.763991179825;48157.27764083612;46541;46902.76548617235;47333.52666473429;47432;47619.28571071367;43219.56780432155;46700.299495506915;47717.761411192725;47867;48849.511504885915;40006.799965999984;40455.59544404518;40771.59228407678;41018.79490602528;41700;30401;30660.693393065783;30886;31031.806830957044;31460 13:42:37 INFO - PROCESS | 25079 | |2;jquery.html;407.3828150352215;409.4022726818844;410.83566573370655;419.5678451195268;425.63395479887294;18858;19532.121054552543;20437.897810510927;20557.794422055795;20574.38276851695;12239.08206884485;12484.063695222849;12507.937460312685;12632.431540580674;12761.361931903391;5178.093833579118;5416.837494875141;5436.972815135919;5459.317585301837;5528.281323427948;5845.912311315334;5860.413958604148;5911.3201981772;5947.970260148693;5952.255968003999;5455.236266922634;5620.494155526002;5826.329972053226;5831.533477321804;5834.183214349994;5276.472352764731;5376.274202982587;5390.164524498709;5416.0792665247;5421.484958928895;5115.053715062725;5242.266082748418;5247.842564723064;5250.7637156328055;5324.1747529133045;14240.216788076652;14256.287185640676;17645.205965731573;24210.394740131636;24406.26781196567;2365.3258821235863;2446.4862378900275;2648.3908700998686;2867.5411934090444;3104.053263754554;10280.280380373377;10361.89638103617;10518.947405262925;10581.047705706447;10802.243842930999;1963.8821670699804;2063.7626672932656;2100.4433825036376;2104.2424727098232;2117.57648470305;85119.14880851175;88289.55855220683;88969.55515222448;89915.55042224812;91144;10773.569057237779;11003.22977391575;11351.375674337825;11351.489182986785;11479.770404591862;15653.530394088195;15765.211739412984;15886.126263055412;15955.60110997211;15980.360785568679;8629.568521573896;8903;8985.236254918405;9072;9099.727008189764;8979.281657467387;9014.63941442348;9018.458892466473;9115;9148.085191480799;4778.331033655291;4815.374001379798;4825.927611085836;4827.396575428072;4853.587445067209;1765.3115285038846;1910.990445047766;2006.1072822594097;2011.728416663761;2016.09275825876;1030.6238223048533;1044.7910417916446;1069.641670040545;1120.467777805552;1128.6896103571582;18495.352662656744;19378.418647440598;20280.391588252376;20691;20824.58350832975;1014.8477728340808;1023.6366090038078;1047.8166320893965;1087.276960821061;1190.6487586162102;10689.732756681145;11281.661550153509;11302.265352752045;11306.152038597138;11345.319280843176;495288;497314;504483;519190;544339;87993.56003220071;90297;91824;105542.47228763807;108470;1085.847981282621;1097.91765617579;1118.6308518188978;1125.774845030997;1134.4044376702298;13940.58178254654;17195.828041719924;17713.645727085644;18308.450746477625;18486.445406637824;44894.77552612216;45606.54393456023;45758.084838302384;45804.08391832078;45979.54020459887;58845.411545883995;59156.70421647864;59342;59449.702751485966;59582.70208649102;8266.545340006116;8757.824843502967;8956.328275379243;9042.90957090447;9310.487923164292;13295.734085318047;13745.725085498434;13784.724305514033;14029.158250505003;14416.711665766836;12390.3185324808;12562.560310389092;12580.622581322576;12781.424835882593;13121.147125436815;12459.93770031144;12601.621951341474;12755.553555625509;12791;12813.871861281641;12351.073669474647;12619.468763470442;12964.67588310262;13078.934605326913;13255.204687718768;9330.766730831783;9364.859527106963;13097.869021309665;13758.380872860545;13988.510402135877;12652.683682908;12949.223046617233;13251.66870828237;13588.660283492993;14000.509982150576 13:42:37 INFO - PROCESS | 25079 | |3;mootools.html;1391.0610338021834;1581.1303782919395;1612.0891696191652;1795.3267524678245;1906.5328994396375;8691.304695624343;9096.727098187057;9130.589123489442;9455.574499147539;9488.857667134982;9188.770280742985;9373.156415922565;9393.201577865873;9396.201322887546;9417.623295068206;2097.6014557234153;2142.036083762305;2143.3784202581232;2426.065964603627;2445.193086281523;2323.9535209295805;2391.198948352304;2395.0659242895285;2413.9981907508363;2422.2491027781357;2410.963835542468;2446;2449.8775061246956;2465.617829236471;2468.9753102469017;2059.8970051497367;2345.9178928737583;2379.583572874749;2397.976020239793;2408.8795560222006;2381.666566680666;2428.9392765180837;2431.149097815768;2431.7446668099947;2436.926892193237;9187.173154416068;9262.814743705088;9305.767355816091;9309.767255818591;9318.440893546409;5293.100172970604;5468.589855760794;5470.206820011076;5477.20580515823;5479.424660410639;3388.40702876998;3475.3744326021306;3509.9122521937156;3516.8769093081874;3520.260745243502;1153.5558809858264;1154.370867877009;1156.6298784388998;1159.8434211381525;1186.9703257418635;13283.933580332037;13366.532171373956;13371.933140334237;13376.93311533446;13395.933020334836;4585.656075794329;4689.484156742756;4751.928721069186;4821.54195351441;4823.95176048235;10967.561297548009;11011.889881101246;11026.724331891766;11074.833877491845;11085.390303533222;5408.486193811582;5465.617406781487;5474.42518535556;5482.725863706799;5491.807786727445;4280.464941882265;4800.495947925488;4960.925586116211;5063.240513922941;5064.518870707277;4025.134596061861;4035.455213546192;4062.532808727034;4148.087420767426;4233.449651545279;1232.9383530823422;1252.6993521554762;1264.0582765839324;1264.5068423314915;1269.2194300505123;1046.4767616191905;1062.574970011986;1064.685917654294;1072.5977758340623;1079.578964203961;6072.36240194782;6227.96886015567;6240.53196010292;6298.118263443122;6332;447.6709618430451;451.5078564364858;458.52084571622737;464.2293792304758;469.94125734283216;4362.432883725095;4467.5532446755715;4474.664400169935;4542.795574199169;4547.681662283609;10840.078593319498;11195.72010699739;11277.379744114152;11284.435778211056;11322.716932076764;10425.843612345821;10851.620193293355;11215.775684486265;11230.719232019264;11232.382218977871;8650.610722517502;8754.430961987451;8790.340724445565;8817.559122043873;8869.73390798277;6457.09600655918;6513.5440519165095;6615.272320044887;6658;6709.731610735711;9630.518474076129;10594;10640.574377024832;10688.732781680521;10713.196510261605;10034.347767395097;10217.74455638615;10224.28430009922;10227;10293.74265643365;6924.376806087476;7993.1607181247455;8073.636686349246;8179.918200818153;8228.62971166287;8176.059753128467;8492.830143397221;8546.444481108709;8570.314374849871;8575.571221438779;7529.887051694339;7716.5755883426955;7778.183290754389;7788.454808163374;7865;7548.3961283098315;7635.46551741395;7678.232176782501;7725.961370193113;7802.141764405797;7047.436205103682;7180.497365184596;7208.96395518019;7214.494985350975;7217.170025447141;5077.5684066853255;5175.81884634051;5216.165413533817;5308.283381743569;5355.116405793001;5366.490183432567;5389.56883449331;5434.2392065110125;5528.364238112507;5534.308211473566 13:42:37 INFO - PROCESS | 25079 | |4;prototype.html;325.84196664617673;328.7830032178762;336.33573691958384;337.3539671529021;338.1495538720118;5377.731113444327;5422.267993820833;5435.798501606851;5457.181422786584;5480.177973303997;5104.320231878266;5217.399999000116;5385.380681221661;5404.32445944257;5463.5902307327015;4242.321228603424;4264.594863487963;4269.978650106761;4290;4292.969687275047;4286.2927616943325;4294.849680261192;4305.622200895715;4306.440162778835;4318.395424640553;4038.5759495253014;4094.0174358153977;4164.500259968808;4182.64447521961;4199.580041995807;4161.126163505667;4170.124273902484;4176.7076304658685;4200.70595058346;4208.915821683565;3747.7376583639157;3764.5294338207723;3767.7362584618813;3771.7925514096714;3774.7165963572515;5176.249443830623;5205.193195054735;5207.385710429779;5261.684578855286;5317.707526086064;4730.361401210827;4795.017021510582;4804.6876952997945;4805.183118869801;4818.855434336975;5623.240862483553;5632.915506267409;5637.182608521742;5649.548036157097;5654.74553645087;4050.3114470539786;4060.050432980826;4090.1819636072905;4095.385692146172;4105.322621767405;5825.38833422493;5843;5855.887381397521;5864.6187997780435;5870.794522191745;4162.604552567501;4171.374293855885;4171.6036976487185;4175.624193822509;4195.811188496464;4143.7306575072525;4229.2598795210715;4230.682698797603;4244.72409293395;4280.16536775332;4799;4803;4805.903881922342;4815.2054910940005;4836.5888899443235;5642.633228840113;5663.32040155184;5674.574406919498;5680.97159514208;5693.035902613592;1410.0623085648135;1411.7670584353673;1449.5289031064947;1449.9415426738328;1463.9285411143326;934.3741889112895;946.6497395963538;948.4878165790396;952.9850708994899;956.6938579654444;4948.140450448655;4956.959038601862;4982.352294201731;5016.269387061458;5044.0920634286185;5110.233464980209;5159.17453207485;5171.405288391883;5218.8956220876125;5249.868753281122;4904.411470623548;4983.476734942778;4986.902881366093;4998.450170481244;5196.220566914917;3118.7992622839915;3129.4679904416303;3131.4676504994204;3136.764742644311;3147.4806656901355;6071.694585664015;6119.969400152971;6121.234845644294;6128.540359473057;6140.263168419819;5740.225069615632;5955.702214889238;5978.701064946822;6009.579329446984;6014.278286605548;6095.024796032613;6108.297545782203;6132.50939924805;6171.413715697002;6183.628982261079;5598.244237028112;5840.795572154954;5887.146363777143;6010.188624535806;6016.067509536029;5791.362950075572;5798.59409841307;5803.767849285981;5814.709264536672;5831.533477321889;6082.787102451393;6110.663913484801;6146.385361463817;6170.660613666112;6187.504999600112;3953;4160.937585936153;4184.958150418579;4194.958050419456;4206.13774176287;5667.40492248308;5906.970465147647;5914.053751399755;5919;5921.200637913998;5590.776368945197;5649.12438572022;5653.095504719226;5682.77268909239;5728.255326807655;5693.572982026281;5695.686737229492;5706.4864162225595;5709.34342550612;5718.313802343579;5474.3704473986;5639.718014099197;5683.8863222736145;5718.313802343745;5730.828075157752;5750.568707346882;5824.388439213822;5835.824925252079;5850.356460789225;5871.647701137775;5441.809536666356;5636;5674.602777805514;5703.914441283301;5723.170140329546 13:42:37 INFO - PROCESS | 25079 | |5;yui.html;765.6095391350414;784.5606460382185;832.0389949608202;842.3135144856938;916.3860213656849;14171.220582867938;14636;15318;15330.846691533096;15348.232588370578;14711.11733296003;15379.384824607003;15383.69232615347;15403;15421.614459638515;729.5440349781387;748.0574476160023;750.0961341583379;878.767126711422;893.5219657483216;743.7062360367652;852.4672079950032;883.1874675298709;884.8009197930478;891.527490430073;916.9770755731093;917.5733284022928;917.807260475301;919.0166521821653;919.3932004876783;752.7704050264667;913.0960349254257;913.8035322405715;914.0539541574472;914.085914085914;656.1633916756126;671.3152584363921;671.3789744486379;674.2078058281548;675.4495086504484;13597;13742.793858092136;13759.587212383645;13773.586792396243;13799.448022079105;12597.307148106851;12830.294333811637;13230.933845330808;13418.7188178009;14294.64263393413;12912;12959.805602915963;13021.479140834355;13171.209727416386;13450.663733406645;3960.2673505401594;4048.210598933209;4053.047533829548;4056.127932494528;4139.523954745183;78517.21482785157;82799;83214.16785832125;83793.58103209505;84450.57774711149;12348.938255308845;12461.439235234437;12496.875031249752;12667.429965651569;12933.870661293267;22981.770182298296;23011.769882301298;23020.7697923022;23059.769402305763;23066;9113.817723645623;9260.490673012915;9558.091981261769;9639.855402168972;9653.372530785477;4888.5111488850835;4972.179590367621;4998.100341938413;5038.974805125951;5049.545540901337;3696.9815150924073;3826.846926122924;3829.5596006459054;3829.885103446901;3830.4062870255157;664.1863716946701;666.4202144134634;672.9966350168315;674.0361283364836;679.3647939176885;652.2564276724443;720.7585458871232;775.6936010276022;776.5884081436848;796.780885256559;10688.251822372515;10754.247202695737;10787.6224332148;10883.564657413615;10926.672199834018;830.7134038756619;830.8462934357042;835.8286551256978;853.753845849449;857.9270761985176;5102.36220472441;5120.7951681933055;5213.869653258699;5245.344331958505;5272.024675435056;112545.43727281311;115571;120120;120887;121205;99619;100294.49852750689;100440.49779751054;100571;101659;88646;89041.55479222562;90591.09408905958;91185.54407227921;91574.54212729027;10092.747681308027;10163.288569800043;10205.438700871524;10221.43782091992;10235.283530152818;52145.7392713034;52884.206736899745;53860.46139538711;54147.458525415816;56158.43841561532;53863.730681346344;79654.601726991;80027.1997280043;80934.595327023;81549.59225204073;14034.578962631138;14181.929090354482;14485.493007744679;14501.274936252934;14636.634084147981;15230.466933657712;15393.076415415111;15431.228438578251;15845.683086337978;16858.494245172664;14470.855291446951;14932.402703891723;15472.613184670474;15874.365025398854;16080.919595401949;13098.607041788762;13135;13736.450541978209;14392.856071439151;15203.239838008276;13179;13269.469221231042;13414.597562073153;13453.529126480526;13715.519956801463;10436.63471778484;10567.682969510926;10868.782624347627;10944.78110437771;10959.945200273947;11798.11514136426;11827.70430739204;11988.580399685969;12036.217645852992;12039.518419263131 13:42:37 INFO - PROCESS | 25079 | __end_tp_report 13:42:37 INFO - PROCESS | 25079 | __start_cc_report 13:42:37 INFO - PROCESS | 25079 | _x_x_mozilla_cycle_collect,795 13:42:37 INFO - PROCESS | 25079 | __end_cc_report 13:42:37 INFO - PROCESS | 25079 | __startTimestamp1468960957505__endTimestamp 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | ------- Summary: start ------- 13:42:37 INFO - PROCESS | 25079 | Number of tests: 6 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#0] dojo.html Cycles:165 Average:5398.33 Median:5589.64 stddev:587.09 (10.5%) stddev-sans-first:565.38 13:42:37 INFO - PROCESS | 25079 | Values: 3301.7 3330.0 3344.5 3369.2 3385.2 5371.6 5460.7 5463.1 5474.8 5493.6 5428.7 5461.5 5461.9 5465.1 5504.3 4833.0 4920.4 4933.8 4971.1 5043.8 4791.7 4921.7 4959.6 4964.3 4977.8 4825.6 4883.2 4927.4 4940.5 4951.5 5004.1 5032.5 5035.0 5035.6 5061.1 4745.6 4886.6 4936.9 4963.5 4996.7 5178.4 5182.4 5204.7 5239.7 5240.4 5693.5 5730.4 5738.7 5744.5 5771.6 5774.0 5801.0 5849.2 5868.4 5904.7 5496.2 5520.4 5536.6 5538.6 5542.4 5787.8 6027.5 6036.1 6039.0 6047.0 5658.7 5682.9 5699.8 5768.6 5786.7 5826.8 5827.0 5844.3 5862.2 5874.4 5624.9 5659.4 5778.9 5785.9 5802.8 5621.8 5692.6 5695.4 5715.2 5750.1 4426.2 4437.8 4444.9 4450.0 4469.6 3956.6 3989.5 3989.9 4012.7 4026.6 5569.2 5578.2 5603.1 5604.5 5631.2 5844.0 5845.2 5850.8 5851.4 5884.8 5350.4 5520.2 5567.2 5575.4 5586.8 5071.9 5089.4 5094.1 5096.3 5116.4 6068.1 6090.5 6097.6 6102.9 6111.6 5553.5 5623.6 5752.7 5772.0 5785.2 6076.1 6077.1 6082.3 6084.4 6102.3 5677.3 5722.5 5723.6 5728.2 5735.6 5637.9 5703.5 5778.7 5781.2 5804.2 5647.8 5658.0 5661.7 5663.3 5671.8 5608.9 5658.4 5670.3 5677.5 5691.8 5457.2 5458.4 5495.7 5501.1 5532.6 5641.5 5696.6 5700.2 5704.2 5704.7 5436.3 5531.6 5566.6 5582.1 5589.6 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#1] ext.html Cycles:180 Average:63419.48 Median:219430.50 stddev:124387.60 (56.7%) stddev-sans-first:124647.13 13:42:37 INFO - PROCESS | 25079 | Values: 602.4 634.3 637.2 644.7 657.1 37068.4 48496.5 48898.8 49233.5 52432.0 50118.7 50571.2 50734.0 50738.5 50777.5 8334.7 9107.8 9287.2 10900.9 11192.0 11036.4 11139.9 11148.8 11149.7 11156.8 11159.9 11218.8 11219.1 11223.1 11228.8 8477.8 11079.8 11341.8 11357.2 11362.8 10794.2 10864.2 10874.8 11211.8 11217.3 46312.8 46646.3 46793.8 46818.0 46896.5 3855.0 3901.3 3904.5 4359.3 4384.1 35198.6 35377.0 36113.8 36301.1 37097.6 4793.8 4833.7 4859.9 4921.9 5002.1 399513.0 404010.0 404461.0 405347.0 405695.0 39348.0 40384.6 69349.3 69900.7 70101.3 42037.2 42343.0 42467.0 42500.8 42502.0 16365.9 17792.2 17927.6 17942.0 17998.1 14335.4 14602.3 14610.1 14947.9 14968.3 9439.8 9445.1 9504.1 9517.1 9540.5 3589.9 3616.4 3646.7 3696.5 3737.3 1075.4 1116.1 1137.5 1179.5 1253.0 35239.6 35707.0 35746.1 35827.8 36131.3 1167.9 1212.1 1226.0 1254.6 1311.5 17932.8 18702.3 18742.3 18749.5 18854.4 589575.0 593887.0 594354.0 595004.0 596173.0 66544.3 67108.3 67187.7 67298.3 67372.3 1334.6 1469.7 1470.7 1493.5 1516.5 35049.8 36480.5 36914.4 37146.8 37227.6 56955.7 57345.4 57591.7 57687.7 57732.0 377286.0 377662.0 378132.0 381812.0 384552.0 27933.0 31282.2 31817.5 32054.2 32280.2 52666.0 53105.0 53523.5 54499.0 54989.7 42918.0 45969.8 46717.3 47201.8 48157.3 46541.0 46902.8 47333.5 47432.0 47619.3 43219.6 46700.3 47717.8 47867.0 48849.5 40006.8 40455.6 40771.6 41018.8 41700.0 30401.0 30660.7 30886.0 31031.8 31460.0 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#2] jquery.html Cycles:180 Average:30187.56 Median:20566.09 stddev:84626.20 (411.5%) stddev-sans-first:84834.05 13:42:37 INFO - PROCESS | 25079 | Values: 407.4 409.4 410.8 419.6 425.6 18858.0 19532.1 20437.9 20557.8 20574.4 12239.1 12484.1 12507.9 12632.4 12761.4 5178.1 5416.8 5437.0 5459.3 5528.3 5845.9 5860.4 5911.3 5948.0 5952.3 5455.2 5620.5 5826.3 5831.5 5834.2 5276.5 5376.3 5390.2 5416.1 5421.5 5115.1 5242.3 5247.8 5250.8 5324.2 14240.2 14256.3 17645.2 24210.4 24406.3 2365.3 2446.5 2648.4 2867.5 3104.1 10280.3 10361.9 10518.9 10581.0 10802.2 1963.9 2063.8 2100.4 2104.2 2117.6 85119.1 88289.6 88969.6 89915.6 91144.0 10773.6 11003.2 11351.4 11351.5 11479.8 15653.5 15765.2 15886.1 15955.6 15980.4 8629.6 8903.0 8985.2 9072.0 9099.7 8979.3 9014.6 9018.5 9115.0 9148.1 4778.3 4815.4 4825.9 4827.4 4853.6 1765.3 1911.0 2006.1 2011.7 2016.1 1030.6 1044.8 1069.6 1120.5 1128.7 18495.4 19378.4 20280.4 20691.0 20824.6 1014.8 1023.6 1047.8 1087.3 1190.6 10689.7 11281.7 11302.3 11306.2 11345.3 495288.0 497314.0 504483.0 519190.0 544339.0 87993.6 90297.0 91824.0 105542.5 108470.0 1085.8 1097.9 1118.6 1125.8 1134.4 13940.6 17195.8 17713.6 18308.5 18486.4 44894.8 45606.5 45758.1 45804.1 45979.5 58845.4 59156.7 59342.0 59449.7 59582.7 8266.5 8757.8 8956.3 9042.9 9310.5 13295.7 13745.7 13784.7 14029.2 14416.7 12390.3 12562.6 12580.6 12781.4 13121.1 12459.9 12601.6 12755.6 12791.0 12813.9 12351.1 12619.5 12964.7 13078.9 13255.2 9330.8 9364.9 13097.9 13758.4 13988.5 12652.7 12949.2 13251.7 13588.7 14000.5 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#3] mootools.html Cycles:180 Average:6005.65 Median:4545.24 stddev:3462.83 (76.2%) stddev-sans-first:3455.18 13:42:37 INFO - PROCESS | 25079 | Values: 1391.1 1581.1 1612.1 1795.3 1906.5 8691.3 9096.7 9130.6 9455.6 9488.9 9188.8 9373.2 9393.2 9396.2 9417.6 2097.6 2142.0 2143.4 2426.1 2445.2 2324.0 2391.2 2395.1 2414.0 2422.2 2411.0 2446.0 2449.9 2465.6 2469.0 2059.9 2345.9 2379.6 2398.0 2408.9 2381.7 2428.9 2431.1 2431.7 2436.9 9187.2 9262.8 9305.8 9309.8 9318.4 5293.1 5468.6 5470.2 5477.2 5479.4 3388.4 3475.4 3509.9 3516.9 3520.3 1153.6 1154.4 1156.6 1159.8 1187.0 13283.9 13366.5 13371.9 13376.9 13395.9 4585.7 4689.5 4751.9 4821.5 4824.0 10967.6 11011.9 11026.7 11074.8 11085.4 5408.5 5465.6 5474.4 5482.7 5491.8 4280.5 4800.5 4960.9 5063.2 5064.5 4025.1 4035.5 4062.5 4148.1 4233.4 1232.9 1252.7 1264.1 1264.5 1269.2 1046.5 1062.6 1064.7 1072.6 1079.6 6072.4 6228.0 6240.5 6298.1 6332.0 447.7 451.5 458.5 464.2 469.9 4362.4 4467.6 4474.7 4542.8 4547.7 10840.1 11195.7 11277.4 11284.4 11322.7 10425.8 10851.6 11215.8 11230.7 11232.4 8650.6 8754.4 8790.3 8817.6 8869.7 6457.1 6513.5 6615.3 6658.0 6709.7 9630.5 10594.0 10640.6 10688.7 10713.2 10034.3 10217.7 10224.3 10227.0 10293.7 6924.4 7993.2 8073.6 8179.9 8228.6 8176.1 8492.8 8546.4 8570.3 8575.6 7529.9 7716.6 7778.2 7788.5 7865.0 7548.4 7635.5 7678.2 7726.0 7802.1 7047.4 7180.5 7209.0 7214.5 7217.2 5077.6 5175.8 5216.2 5308.3 5355.1 5366.5 5389.6 5434.2 5528.4 5534.3 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#4] prototype.html Cycles:180 Average:4761.68 Median:5289.70 stddev:1404.73 (26.6%) stddev-sans-first:1368.65 13:42:37 INFO - PROCESS | 25079 | Values: 325.8 328.8 336.3 337.4 338.1 5377.7 5422.3 5435.8 5457.2 5480.2 5104.3 5217.4 5385.4 5404.3 5463.6 4242.3 4264.6 4270.0 4290.0 4293.0 4286.3 4294.8 4305.6 4306.4 4318.4 4038.6 4094.0 4164.5 4182.6 4199.6 4161.1 4170.1 4176.7 4200.7 4208.9 3747.7 3764.5 3767.7 3771.8 3774.7 5176.2 5205.2 5207.4 5261.7 5317.7 4730.4 4795.0 4804.7 4805.2 4818.9 5623.2 5632.9 5637.2 5649.5 5654.7 4050.3 4060.1 4090.2 4095.4 4105.3 5825.4 5843.0 5855.9 5864.6 5870.8 4162.6 4171.4 4171.6 4175.6 4195.8 4143.7 4229.3 4230.7 4244.7 4280.2 4799.0 4803.0 4805.9 4815.2 4836.6 5642.6 5663.3 5674.6 5681.0 5693.0 1410.1 1411.8 1449.5 1449.9 1463.9 934.4 946.6 948.5 953.0 956.7 4948.1 4957.0 4982.4 5016.3 5044.1 5110.2 5159.2 5171.4 5218.9 5249.9 4904.4 4983.5 4986.9 4998.5 5196.2 3118.8 3129.5 3131.5 3136.8 3147.5 6071.7 6120.0 6121.2 6128.5 6140.3 5740.2 5955.7 5978.7 6009.6 6014.3 6095.0 6108.3 6132.5 6171.4 6183.6 5598.2 5840.8 5887.1 6010.2 6016.1 5791.4 5798.6 5803.8 5814.7 5831.5 6082.8 6110.7 6146.4 6170.7 6187.5 3953.0 4160.9 4185.0 4195.0 4206.1 5667.4 5907.0 5914.1 5919.0 5921.2 5590.8 5649.1 5653.1 5682.8 5728.3 5693.6 5695.7 5706.5 5709.3 5718.3 5474.4 5639.7 5683.9 5718.3 5730.8 5750.6 5824.4 5835.8 5850.4 5871.6 5441.8 5636.0 5674.6 5703.9 5723.2 13:42:37 INFO - PROCESS | 25079 | 13:42:37 INFO - PROCESS | 25079 | [#5] yui.html Cycles:180 Average:21597.49 Median:3828.20 stddev:30951.80 (808.5%) stddev-sans-first:30999.10 13:42:37 INFO - PROCESS | 25079 | Values: 765.6 784.6 832.0 842.3 916.4 14171.2 14636.0 15318.0 15330.8 15348.2 14711.1 15379.4 15383.7 15403.0 15421.6 729.5 748.1 750.1 878.8 893.5 743.7 852.5 883.2 884.8 891.5 917.0 917.6 917.8 919.0 919.4 752.8 913.1 913.8 914.1 914.1 656.2 671.3 671.4 674.2 675.4 13597.0 13742.8 13759.6 13773.6 13799.4 12597.3 12830.3 13230.9 13418.7 14294.6 12912.0 12959.8 13021.5 13171.2 13450.7 3960.3 4048.2 4053.0 4056.1 4139.5 78517.2 82799.0 83214.2 83793.6 84450.6 12348.9 12461.4 12496.9 12667.4 12933.9 22981.8 23011.8 23020.8 23059.8 23066.0 9113.8 9260.5 9558.1 9639.9 9653.4 4888.5 4972.2 4998.1 5039.0 5049.5 3697.0 3826.8 3829.6 3829.9 3830.4 664.2 666.4 673.0 674.0 679.4 652.3 720.8 775.7 776.6 796.8 10688.3 10754.2 10787.6 10883.6 10926.7 830.7 830.8 835.8 853.8 857.9 5102.4 5120.8 5213.9 5245.3 5272.0 112545.4 115571.0 120120.0 120887.0 121205.0 99619.0 100294.5 100440.5 100571.0 101659.0 88646.0 89041.6 90591.1 91185.5 91574.5 10092.7 10163.3 10205.4 10221.4 10235.3 52145.7 52884.2 53860.5 54147.5 56158.4 53863.7 79654.6 80027.2 80934.6 81549.6 14034.6 14181.9 14485.5 14501.3 14636.6 15230.5 15393.1 15431.2 15845.7 16858.5 14470.9 14932.4 15472.6 15874.4 16080.9 13098.6 13135.0 13736.5 14392.9 15203.2 13179.0 13269.5 13414.6 13453.5 13715.5 10436.6 10567.7 10868.8 10944.8 10959.9 11798.1 11827.7 11988.6 12036.2 12039.5 13:42:37 INFO - PROCESS | 25079 | -------- Summary: end -------- 13:42:37 INFO - PROCESS | 25079 | 13:42:38 INFO - TEST-INFO | 25079: exit 0 13:42:38 INFO - TEST-OK | dromaeo_css | took 1113013ms 13:42:38 INFO - TEST-START | kraken 13:42:38 INFO - operating with platform_type : linux_ 13:42:38 INFO - Initialising browser for kraken test... 13:42:38 INFO - TEST-INFO | started process 25265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyWkIQ/profile http://localhost:44135/getInfo.html) 13:42:42 INFO - PROCESS | 25265 | __metrics Screen width/height:1600/1200 13:42:42 INFO - PROCESS | 25265 | colorDepth:24 13:42:42 INFO - PROCESS | 25265 | Browser inner width/height: 1024/697 13:42:42 INFO - PROCESS | 25265 | __metrics 13:42:43 INFO - PROCESS | 25265 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:42:43 ERROR - PROCESS | 25265 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:42:43 INFO - TEST-INFO | 25265: exit 0 13:42:43 INFO - Browser initialized. 13:42:43 INFO - Running cycle 1/1 for kraken test... 13:42:43 INFO - TEST-INFO | started process 25357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyWkIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:55 INFO - PROCESS | 25357 | RSS: Main: 149360640 13:42:55 INFO - PROCESS | 25357 | 13:42:58 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44135/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:58 INFO - PROCESS | 25357 | RSS: Main: 197603328 13:42:58 INFO - PROCESS | 25357 | 13:43:01 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44135/tests/kraken/driver.html?testName=audio-dft) 13:43:02 INFO - PROCESS | 25357 | RSS: Main: 196919296 13:43:02 INFO - PROCESS | 25357 | 13:43:04 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44135/tests/kraken/driver.html?testName=audio-fft) 13:43:05 INFO - PROCESS | 25357 | RSS: Main: 282267648 13:43:05 INFO - PROCESS | 25357 | 13:43:07 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44135/tests/kraken/driver.html?testName=audio-oscillator) 13:43:08 INFO - PROCESS | 25357 | RSS: Main: 191324160 13:43:08 INFO - PROCESS | 25357 | 13:43:10 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44135/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:43:10 INFO - PROCESS | 25357 | RSS: Main: 191451136 13:43:10 INFO - PROCESS | 25357 | 13:43:13 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44135/tests/kraken/driver.html?testName=imaging-darkroom) 13:43:14 INFO - PROCESS | 25357 | RSS: Main: 226373632 13:43:14 INFO - PROCESS | 25357 | 13:43:17 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44135/tests/kraken/driver.html?testName=imaging-desaturate) 13:43:18 INFO - PROCESS | 25357 | RSS: Main: 227291136 13:43:18 INFO - PROCESS | 25357 | 13:43:21 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44135/tests/kraken/driver.html?testName=json-parse-financial) 13:43:21 INFO - PROCESS | 25357 | RSS: Main: 227184640 13:43:21 INFO - PROCESS | 25357 | 13:43:23 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44135/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:23 INFO - PROCESS | 25357 | RSS: Main: 205037568 13:43:23 INFO - PROCESS | 25357 | 13:43:25 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:26 INFO - PROCESS | 25357 | RSS: Main: 205967360 13:43:26 INFO - PROCESS | 25357 | 13:43:28 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:29 INFO - PROCESS | 25357 | RSS: Main: 209956864 13:43:29 INFO - PROCESS | 25357 | 13:43:31 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:32 INFO - PROCESS | 25357 | RSS: Main: 215494656 13:43:32 INFO - PROCESS | 25357 | 13:43:34 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:35 INFO - PROCESS | 25357 | RSS: Main: 217264128 13:43:35 INFO - PROCESS | 25357 | 13:43:36 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:44135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44135/tests/kraken/driver.html?testName=ai-astar) 13:43:37 INFO - PROCESS | 25357 | RSS: Main: 259592192 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | __start_tp_report 13:43:37 INFO - PROCESS | 25357 | _x_x_mozilla_page_load 13:43:37 INFO - PROCESS | 25357 | _x_x_mozilla_page_load_details 13:43:37 INFO - PROCESS | 25357 | |i|pagename|runs| 13:43:37 INFO - PROCESS | 25357 | |0;ai-astar;111;104;111;109;109;110;108;111;110;110 13:43:37 INFO - PROCESS | 25357 | |1;audio-beat-detection;154;127;124;174;126;124;148;126;153;127 13:43:37 INFO - PROCESS | 25357 | |2;audio-dft;165;162;161;160;162;163;160;163;162;162 13:43:37 INFO - PROCESS | 25357 | |3;audio-fft;76;75;74;122;77;76;74;74;106;74 13:43:37 INFO - PROCESS | 25357 | |4;audio-oscillator;85;85;120;84;84;84;116;85;85;129 13:43:37 INFO - PROCESS | 25357 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 13:43:37 INFO - PROCESS | 25357 | |6;imaging-darkroom;146;147;146;146;147;146;145;145;146;145 13:43:37 INFO - PROCESS | 25357 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;96 13:43:37 INFO - PROCESS | 25357 | |8;json-parse-financial;51;50;51;52;54;52;52;64;51;53 13:43:37 INFO - PROCESS | 25357 | |9;json-stringify-tinderbox;62;60;61;61;61;60;60;60;60;61 13:43:37 INFO - PROCESS | 25357 | |10;stanford-crypto-aes;75;81;82;82;76;83;78;76;107;77 13:43:37 INFO - PROCESS | 25357 | |11;stanford-crypto-ccm;119;119;120;127;115;113;116;121;132;127 13:43:37 INFO - PROCESS | 25357 | |12;stanford-crypto-pbkdf2;152;151;152;155;160;149;150;149;150;150 13:43:37 INFO - PROCESS | 25357 | |13;stanford-crypto-sha256-iterative;62;62;61;61;64;62;62;60;59;61 13:43:37 INFO - PROCESS | 25357 | __end_tp_report 13:43:37 INFO - PROCESS | 25357 | __start_cc_report 13:43:37 INFO - PROCESS | 25357 | _x_x_mozilla_cycle_collect,1568 13:43:37 INFO - PROCESS | 25357 | __end_cc_report 13:43:37 INFO - PROCESS | 25357 | __startTimestamp1468961017233__endTimestamp 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | ------- Summary: start ------- 13:43:37 INFO - PROCESS | 25357 | Number of tests: 14 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.11 (1.9%) stddev-sans-first:2.15 13:43:37 INFO - PROCESS | 25357 | Values: 111.0 104.0 111.0 109.0 109.0 110.0 108.0 111.0 110.0 110.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:137.50 stddev:17.63 (12.8%) stddev-sans-first:17.76 13:43:37 INFO - PROCESS | 25357 | Values: 154.0 127.0 124.0 174.0 126.0 124.0 148.0 126.0 153.0 127.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.12 13:43:37 INFO - PROCESS | 25357 | Values: 165.0 162.0 161.0 160.0 162.0 163.0 160.0 163.0 162.0 162.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.50 stddev:16.90 (22.7%) stddev-sans-first:17.75 13:43:37 INFO - PROCESS | 25357 | Values: 76.0 75.0 74.0 122.0 77.0 76.0 74.0 74.0 106.0 74.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.50 stddev:18.20 (21.5%) stddev-sans-first:18.88 13:43:37 INFO - PROCESS | 25357 | Values: 85.0 85.0 120.0 84.0 84.0 84.0 116.0 85.0 85.0 129.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:43:37 INFO - PROCESS | 25357 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:43:37 INFO - PROCESS | 25357 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 145.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:43:37 INFO - PROCESS | 25357 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 96.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.00 stddev:4.03 (7.7%) stddev-sans-first:4.21 13:43:37 INFO - PROCESS | 25357 | Values: 51.0 50.0 51.0 52.0 54.0 52.0 52.0 64.0 51.0 53.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 13:43:37 INFO - PROCESS | 25357 | Values: 62.0 60.0 61.0 61.0 61.0 60.0 60.0 60.0 60.0 61.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:79.50 stddev:9.36 (11.8%) stddev-sans-first:9.61 13:43:37 INFO - PROCESS | 25357 | Values: 75.0 81.0 82.0 82.0 76.0 83.0 78.0 76.0 107.0 77.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:120.50 stddev:6.03 (5.0%) stddev-sans-first:6.35 13:43:37 INFO - PROCESS | 25357 | Values: 119.0 119.0 120.0 127.0 115.0 113.0 116.0 121.0 132.0 127.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:151.50 stddev:3.39 (2.2%) stddev-sans-first:3.60 13:43:37 INFO - PROCESS | 25357 | Values: 152.0 151.0 152.0 155.0 160.0 149.0 150.0 149.0 150.0 150.0 13:43:37 INFO - PROCESS | 25357 | 13:43:37 INFO - PROCESS | 25357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.41 13:43:37 INFO - PROCESS | 25357 | Values: 62.0 62.0 61.0 61.0 64.0 62.0 62.0 60.0 59.0 61.0 13:43:37 INFO - PROCESS | 25357 | -------- Summary: end -------- 13:43:37 INFO - PROCESS | 25357 | 13:43:38 INFO - TEST-INFO | 25357: exit 0 13:43:38 INFO - TEST-OK | kraken | took 59996ms 13:43:38 INFO - SUITE-END | took 1173s 13:43:38 INFO - Completed test suite (00:19:33) 13:43:38 INFO - javascript benchmark 13:43:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.7193538549222, 3329.966700332996, 3344.498325251213, 3369.174552234703, 3385.153711572107, 5371.623986320959, 5460.699661518614, 5463.098588732854, 5474.835754927349, 5493.587980901433, 5428.701421421821, 5461.5357694595905, 5461.890762184754, 5465.098258787305, 5504.339479262494, 4833.0, 4920.384951881015, 4933.777979990909, 4971.080350135218, 5043.798248070073, 4791.736454495001, 4921.655484116113, 4959.628027897904, 4964.255361695738, 4977.825776097838, 4825.638077144211, 4883.169861123618, 4927.408710954691, 4940.481249468808, 4951.455339912607, 5004.099262132815, 5032.4967503249745, 5034.974825125851, 5035.62232832539, 5061.1143049966295, 4745.620350371962, 4886.584640305578, 4936.901261974776, 4963.45402005779, 4996.725180115092, 5178.40448348441, 5182.352205974254, 5204.739763011834, 5239.659422137587, 5240.371155461331, 5693.459121383462, 5730.36965933747, 5738.655680659173, 5744.511716504102, 5771.59598828078, 5773.971130144364, 5800.9709951450395, 5849.181114643953, 5868.4424979626865, 5904.675242861641, 5496.203050557687, 5520.365158006881, 5536.584756143306, 5538.612297139242, 5542.362628297717, 5787.826365209051, 6027.487663548647, 6036.124761909498, 6038.969805150946, 6046.969765151146, 5658.7170641467765, 5682.943170568324, 5699.772009119672, 5768.596198266081, 5786.739596718157, 5826.766929322865, 5826.970865145647, 5844.26946631671, 5862.237909071793, 5874.383189765099, 5624.887502249932, 5659.43405659439, 5778.855528611818, 5785.884282314414, 5802.796902108406, 5621.831345059655, 5692.6299790513485, 5695.373508914016, 5715.228444159985, 5750.079987202028, 4426.18115648606, 4437.755923424243, 4444.933326000112, 4450.043240703264, 4469.642428605704, 3956.564777874489, 3989.501312335958, 3989.940150897739, 4012.6789856811383, 4026.617471340218, 5569.248151499577, 5578.163275508625, 5603.131514615241, 5604.523615492729, 5631.18347839561, 5844.006518891713, 5845.181674565564, 5850.795222167289, 5851.414858514199, 5884.764609415575, 5350.438203988603, 5520.199571062254, 5567.164925261243, 5575.358833734092, 5586.832395028075, 5071.873203169876, 5089.440161582223, 5094.108531007133, 5096.261042148868, 5116.360454943132, 6068.089786532056, 6090.451859332593, 6097.634141951497, 6102.931986902275, 6111.602745821508, 5553.4724201200825, 5623.550115990629, 5752.654840709571, 5772.047612144117, 5785.247917770663, 6076.1493390924425, 6077.118817771487, 6082.300535438481, 6084.39156084388, 6102.267727872683, 5677.318721753416, 5722.484976352148, 5723.570732195185, 5728.198052272602, 5735.627184233012, 5637.915431268616, 5703.543716502587, 5778.739956702043, 5781.248437703071, 5804.187413762161, 5647.830565083054, 5657.971710141423, 5661.745221465127, 5663.263775709132, 5671.801486947937, 5608.85977850557, 5658.377578466448, 5670.291213598301, 5677.5457963362005, 5691.8292451226525, 5457.154141107976, 5458.426865179099, 5495.697736624524, 5501.14732216507, 5532.612717109924, 5641.464060914206, 5696.629719068247, 5700.201971723879, 5704.201411802268, 5704.657720536781, 5436.266104075899, 5531.640443371168, 5566.610337276352, 5582.078956972054, 5589.636673616202], "value": 5361.445783079155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3675141101842, 634.2674211285965, 637.2003136064236, 644.6744394080988, 657.0964923230558, 37068.443973340385, 48496.51503484964, 48898.75550622242, 49233.50766492334, 52432.0, 50118.74940625301, 50571.241431378556, 50734.0, 50738.492615073934, 50777.49222507774, 8334.70828521002, 9107.772305692377, 9287.164155226028, 10900.945495272552, 11192.048675862521, 11036.448177591128, 11139.888601113966, 11148.777024459507, 11149.7212569686, 11156.776864462707, 11159.888401116006, 11218.775624487505, 11219.102471802236, 11223.102151827876, 11228.775424491505, 8477.788055298635, 11079.778404431867, 11341.829872551918, 11357.204995650307, 11362.772744545146, 10794.190435717353, 10864.239503234776, 10874.782504349869, 11211.831822522669, 11217.326960382321, 46312.76843615794, 46646.300305495446, 46793.76603116962, 46818.0, 46896.53103468956, 3855.0, 3901.336772748611, 3904.4728961590104, 4359.302511598161, 4384.079343337903, 35198.64801352005, 35377.0, 36113.81943090294, 36301.09247268813, 37097.62902370969, 4793.784279707422, 4833.734144622044, 4859.902801943941, 4921.926171107436, 5002.074616196015, 399513.0, 404010.0, 404461.0, 405347.0, 405695.0, 39348.0, 40384.59615403867, 69349.30650693529, 69900.6504967482, 70101.2989870105, 42037.159256814695, 42343.0, 42467.0, 42500.78749606232, 42502.0, 16365.91817040931, 17792.199351028976, 17927.641447171245, 17942.0, 17998.1000949952, 14335.426582936565, 14602.269886505632, 14610.123392596479, 14947.925260373846, 14968.251587420586, 9439.764005899908, 9445.102715242041, 9504.097110774464, 9517.143457088896, 9540.475273859865, 3589.9102522437147, 3616.4213725803747, 3646.6717995380545, 3696.482492451059, 3737.3085979093953, 1075.381655548063, 1116.1238427834112, 1137.5475432063647, 1179.5399794080315, 1253.022642338977, 35239.647603523634, 35707.0, 35746.10634734153, 35827.82086089553, 36131.277374452366, 1167.8890505401973, 1212.0788200967152, 1225.993870030662, 1254.5859866244118, 1311.5081844308384, 17932.820671793375, 18702.251909923452, 18742.344017959305, 18749.531261718566, 18854.434366969013, 589575.0, 593887.0, 594354.0, 595004.0, 596173.0, 66544.33455665478, 67108.3289167102, 67187.66406167937, 67298.32701673018, 67372.32627673661, 1334.5595953335376, 1469.7060587882465, 1470.6985068061022, 1493.5220729366715, 1516.5298757385026, 35049.8247508771, 36480.452793207594, 36914.44628330631, 37146.8142659285, 37227.62772372241, 56955.71522142363, 57345.42654573401, 57591.712041439525, 57687.71156144192, 57732.0, 377286.0, 377662.0, 378132.0, 381812.0, 384552.0, 27933.0, 31282.21794455157, 31817.522737159423, 32054.19864503406, 32280.192995175308, 52666.0, 53105.0, 53523.46476535185, 54499.0, 54989.72505137449, 42918.0, 45969.77015114903, 46717.2992405121, 47201.763991179825, 48157.27764083612, 46541.0, 46902.76548617235, 47333.52666473429, 47432.0, 47619.28571071367, 43219.56780432155, 46700.299495506915, 47717.761411192725, 47867.0, 48849.511504885915, 40006.799965999984, 40455.59544404518, 40771.59228407678, 41018.79490602528, 41700.0, 30401.0, 30660.693393065783, 30886.0, 31031.806830957044, 31460.0], "value": 21253.094148035416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.3828150352215, 409.4022726818844, 410.83566573370655, 419.5678451195268, 425.63395479887294, 18858.0, 19532.121054552543, 20437.897810510927, 20557.794422055795, 20574.38276851695, 12239.08206884485, 12484.063695222849, 12507.937460312685, 12632.431540580674, 12761.361931903391, 5178.093833579118, 5416.837494875141, 5436.972815135919, 5459.317585301837, 5528.281323427948, 5845.912311315334, 5860.413958604148, 5911.3201981772, 5947.970260148693, 5952.255968003999, 5455.236266922634, 5620.494155526002, 5826.329972053226, 5831.533477321804, 5834.183214349994, 5276.472352764731, 5376.274202982587, 5390.164524498709, 5416.0792665247, 5421.484958928895, 5115.053715062725, 5242.266082748418, 5247.842564723064, 5250.7637156328055, 5324.1747529133045, 14240.216788076652, 14256.287185640676, 17645.205965731573, 24210.394740131636, 24406.26781196567, 2365.3258821235863, 2446.4862378900275, 2648.3908700998686, 2867.5411934090444, 3104.053263754554, 10280.280380373377, 10361.89638103617, 10518.947405262925, 10581.047705706447, 10802.243842930999, 1963.8821670699804, 2063.7626672932656, 2100.4433825036376, 2104.2424727098232, 2117.57648470305, 85119.14880851175, 88289.55855220683, 88969.55515222448, 89915.55042224812, 91144.0, 10773.569057237779, 11003.22977391575, 11351.375674337825, 11351.489182986785, 11479.770404591862, 15653.530394088195, 15765.211739412984, 15886.126263055412, 15955.60110997211, 15980.360785568679, 8629.568521573896, 8903.0, 8985.236254918405, 9072.0, 9099.727008189764, 8979.281657467387, 9014.63941442348, 9018.458892466473, 9115.0, 9148.085191480799, 4778.331033655291, 4815.374001379798, 4825.927611085836, 4827.396575428072, 4853.587445067209, 1765.3115285038846, 1910.990445047766, 2006.1072822594097, 2011.728416663761, 2016.09275825876, 1030.6238223048533, 1044.7910417916446, 1069.641670040545, 1120.467777805552, 1128.6896103571582, 18495.352662656744, 19378.418647440598, 20280.391588252376, 20691.0, 20824.58350832975, 1014.8477728340808, 1023.6366090038078, 1047.8166320893965, 1087.276960821061, 1190.6487586162102, 10689.732756681145, 11281.661550153509, 11302.265352752045, 11306.152038597138, 11345.319280843176, 495288.0, 497314.0, 504483.0, 519190.0, 544339.0, 87993.56003220071, 90297.0, 91824.0, 105542.47228763807, 108470.0, 1085.847981282621, 1097.91765617579, 1118.6308518188978, 1125.774845030997, 1134.4044376702298, 13940.58178254654, 17195.828041719924, 17713.645727085644, 18308.450746477625, 18486.445406637824, 44894.77552612216, 45606.54393456023, 45758.084838302384, 45804.08391832078, 45979.54020459887, 58845.411545883995, 59156.70421647864, 59342.0, 59449.702751485966, 59582.70208649102, 8266.545340006116, 8757.824843502967, 8956.328275379243, 9042.90957090447, 9310.487923164292, 13295.734085318047, 13745.725085498434, 13784.724305514033, 14029.158250505003, 14416.711665766836, 12390.3185324808, 12562.560310389092, 12580.622581322576, 12781.424835882593, 13121.147125436815, 12459.93770031144, 12601.621951341474, 12755.553555625509, 12791.0, 12813.871861281641, 12351.073669474647, 12619.468763470442, 12964.67588310262, 13078.934605326913, 13255.204687718768, 9330.766730831783, 9364.859527106963, 13097.869021309665, 13758.380872860545, 13988.510402135877, 12652.683682908, 12949.223046617233, 13251.66870828237, 13588.660283492993, 14000.509982150576], "value": 9545.452318589403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.0610338021834, 1581.1303782919395, 1612.0891696191652, 1795.3267524678245, 1906.5328994396375, 8691.304695624343, 9096.727098187057, 9130.589123489442, 9455.574499147539, 9488.857667134982, 9188.770280742985, 9373.156415922565, 9393.201577865873, 9396.201322887546, 9417.623295068206, 2097.6014557234153, 2142.036083762305, 2143.3784202581232, 2426.065964603627, 2445.193086281523, 2323.9535209295805, 2391.198948352304, 2395.0659242895285, 2413.9981907508363, 2422.2491027781357, 2410.963835542468, 2446.0, 2449.8775061246956, 2465.617829236471, 2468.9753102469017, 2059.8970051497367, 2345.9178928737583, 2379.583572874749, 2397.976020239793, 2408.8795560222006, 2381.666566680666, 2428.9392765180837, 2431.149097815768, 2431.7446668099947, 2436.926892193237, 9187.173154416068, 9262.814743705088, 9305.767355816091, 9309.767255818591, 9318.440893546409, 5293.100172970604, 5468.589855760794, 5470.206820011076, 5477.20580515823, 5479.424660410639, 3388.40702876998, 3475.3744326021306, 3509.9122521937156, 3516.8769093081874, 3520.260745243502, 1153.5558809858264, 1154.370867877009, 1156.6298784388998, 1159.8434211381525, 1186.9703257418635, 13283.933580332037, 13366.532171373956, 13371.933140334237, 13376.93311533446, 13395.933020334836, 4585.656075794329, 4689.484156742756, 4751.928721069186, 4821.54195351441, 4823.95176048235, 10967.561297548009, 11011.889881101246, 11026.724331891766, 11074.833877491845, 11085.390303533222, 5408.486193811582, 5465.617406781487, 5474.42518535556, 5482.725863706799, 5491.807786727445, 4280.464941882265, 4800.495947925488, 4960.925586116211, 5063.240513922941, 5064.518870707277, 4025.134596061861, 4035.455213546192, 4062.532808727034, 4148.087420767426, 4233.449651545279, 1232.9383530823422, 1252.6993521554762, 1264.0582765839324, 1264.5068423314915, 1269.2194300505123, 1046.4767616191905, 1062.574970011986, 1064.685917654294, 1072.5977758340623, 1079.578964203961, 6072.36240194782, 6227.96886015567, 6240.53196010292, 6298.118263443122, 6332.0, 447.6709618430451, 451.5078564364858, 458.52084571622737, 464.2293792304758, 469.94125734283216, 4362.432883725095, 4467.5532446755715, 4474.664400169935, 4542.795574199169, 4547.681662283609, 10840.078593319498, 11195.72010699739, 11277.379744114152, 11284.435778211056, 11322.716932076764, 10425.843612345821, 10851.620193293355, 11215.775684486265, 11230.719232019264, 11232.382218977871, 8650.610722517502, 8754.430961987451, 8790.340724445565, 8817.559122043873, 8869.73390798277, 6457.09600655918, 6513.5440519165095, 6615.272320044887, 6658.0, 6709.731610735711, 9630.518474076129, 10594.0, 10640.574377024832, 10688.732781680521, 10713.196510261605, 10034.347767395097, 10217.74455638615, 10224.28430009922, 10227.0, 10293.74265643365, 6924.376806087476, 7993.1607181247455, 8073.636686349246, 8179.918200818153, 8228.62971166287, 8176.059753128467, 8492.830143397221, 8546.444481108709, 8570.314374849871, 8575.571221438779, 7529.887051694339, 7716.5755883426955, 7778.183290754389, 7788.454808163374, 7865.0, 7548.3961283098315, 7635.46551741395, 7678.232176782501, 7725.961370193113, 7802.141764405797, 7047.436205103682, 7180.497365184596, 7208.96395518019, 7214.494985350975, 7217.170025447141, 5077.5684066853255, 5175.81884634051, 5216.165413533817, 5308.283381743569, 5355.116405793001, 5366.490183432567, 5389.56883449331, 5434.2392065110125, 5528.364238112507, 5534.308211473566], "value": 4711.596214625046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.84196664617673, 328.7830032178762, 336.33573691958384, 337.3539671529021, 338.1495538720118, 5377.731113444327, 5422.267993820833, 5435.798501606851, 5457.181422786584, 5480.177973303997, 5104.320231878266, 5217.399999000116, 5385.380681221661, 5404.32445944257, 5463.5902307327015, 4242.321228603424, 4264.594863487963, 4269.978650106761, 4290.0, 4292.969687275047, 4286.2927616943325, 4294.849680261192, 4305.622200895715, 4306.440162778835, 4318.395424640553, 4038.5759495253014, 4094.0174358153977, 4164.500259968808, 4182.64447521961, 4199.580041995807, 4161.126163505667, 4170.124273902484, 4176.7076304658685, 4200.70595058346, 4208.915821683565, 3747.7376583639157, 3764.5294338207723, 3767.7362584618813, 3771.7925514096714, 3774.7165963572515, 5176.249443830623, 5205.193195054735, 5207.385710429779, 5261.684578855286, 5317.707526086064, 4730.361401210827, 4795.017021510582, 4804.6876952997945, 4805.183118869801, 4818.855434336975, 5623.240862483553, 5632.915506267409, 5637.182608521742, 5649.548036157097, 5654.74553645087, 4050.3114470539786, 4060.050432980826, 4090.1819636072905, 4095.385692146172, 4105.322621767405, 5825.38833422493, 5843.0, 5855.887381397521, 5864.6187997780435, 5870.794522191745, 4162.604552567501, 4171.374293855885, 4171.6036976487185, 4175.624193822509, 4195.811188496464, 4143.7306575072525, 4229.2598795210715, 4230.682698797603, 4244.72409293395, 4280.16536775332, 4799.0, 4803.0, 4805.903881922342, 4815.2054910940005, 4836.5888899443235, 5642.633228840113, 5663.32040155184, 5674.574406919498, 5680.97159514208, 5693.035902613592, 1410.0623085648135, 1411.7670584353673, 1449.5289031064947, 1449.9415426738328, 1463.9285411143326, 934.3741889112895, 946.6497395963538, 948.4878165790396, 952.9850708994899, 956.6938579654444, 4948.140450448655, 4956.959038601862, 4982.352294201731, 5016.269387061458, 5044.0920634286185, 5110.233464980209, 5159.17453207485, 5171.405288391883, 5218.8956220876125, 5249.868753281122, 4904.411470623548, 4983.476734942778, 4986.902881366093, 4998.450170481244, 5196.220566914917, 3118.7992622839915, 3129.4679904416303, 3131.4676504994204, 3136.764742644311, 3147.4806656901355, 6071.694585664015, 6119.969400152971, 6121.234845644294, 6128.540359473057, 6140.263168419819, 5740.225069615632, 5955.702214889238, 5978.701064946822, 6009.579329446984, 6014.278286605548, 6095.024796032613, 6108.297545782203, 6132.50939924805, 6171.413715697002, 6183.628982261079, 5598.244237028112, 5840.795572154954, 5887.146363777143, 6010.188624535806, 6016.067509536029, 5791.362950075572, 5798.59409841307, 5803.767849285981, 5814.709264536672, 5831.533477321889, 6082.787102451393, 6110.663913484801, 6146.385361463817, 6170.660613666112, 6187.504999600112, 3953.0, 4160.937585936153, 4184.958150418579, 4194.958050419456, 4206.13774176287, 5667.40492248308, 5906.970465147647, 5914.053751399755, 5919.0, 5921.200637913998, 5590.776368945197, 5649.12438572022, 5653.095504719226, 5682.77268909239, 5728.255326807655, 5693.572982026281, 5695.686737229492, 5706.4864162225595, 5709.34342550612, 5718.313802343579, 5474.3704473986, 5639.718014099197, 5683.8863222736145, 5718.313802343745, 5730.828075157752, 5750.568707346882, 5824.388439213822, 5835.824925252079, 5850.356460789225, 5871.647701137775, 5441.809536666356, 5636.0, 5674.602777805514, 5703.914441283301, 5723.170140329546], "value": 4312.123674503106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.6095391350414, 784.5606460382185, 832.0389949608202, 842.3135144856938, 916.3860213656849, 14171.220582867938, 14636.0, 15318.0, 15330.846691533096, 15348.232588370578, 14711.11733296003, 15379.384824607003, 15383.69232615347, 15403.0, 15421.614459638515, 729.5440349781387, 748.0574476160023, 750.0961341583379, 878.767126711422, 893.5219657483216, 743.7062360367652, 852.4672079950032, 883.1874675298709, 884.8009197930478, 891.527490430073, 916.9770755731093, 917.5733284022928, 917.807260475301, 919.0166521821653, 919.3932004876783, 752.7704050264667, 913.0960349254257, 913.8035322405715, 914.0539541574472, 914.085914085914, 656.1633916756126, 671.3152584363921, 671.3789744486379, 674.2078058281548, 675.4495086504484, 13597.0, 13742.793858092136, 13759.587212383645, 13773.586792396243, 13799.448022079105, 12597.307148106851, 12830.294333811637, 13230.933845330808, 13418.7188178009, 14294.64263393413, 12912.0, 12959.805602915963, 13021.479140834355, 13171.209727416386, 13450.663733406645, 3960.2673505401594, 4048.210598933209, 4053.047533829548, 4056.127932494528, 4139.523954745183, 78517.21482785157, 82799.0, 83214.16785832125, 83793.58103209505, 84450.57774711149, 12348.938255308845, 12461.439235234437, 12496.875031249752, 12667.429965651569, 12933.870661293267, 22981.770182298296, 23011.769882301298, 23020.7697923022, 23059.769402305763, 23066.0, 9113.817723645623, 9260.490673012915, 9558.091981261769, 9639.855402168972, 9653.372530785477, 4888.5111488850835, 4972.179590367621, 4998.100341938413, 5038.974805125951, 5049.545540901337, 3696.9815150924073, 3826.846926122924, 3829.5596006459054, 3829.885103446901, 3830.4062870255157, 664.1863716946701, 666.4202144134634, 672.9966350168315, 674.0361283364836, 679.3647939176885, 652.2564276724443, 720.7585458871232, 775.6936010276022, 776.5884081436848, 796.780885256559, 10688.251822372515, 10754.247202695737, 10787.6224332148, 10883.564657413615, 10926.672199834018, 830.7134038756619, 830.8462934357042, 835.8286551256978, 853.753845849449, 857.9270761985176, 5102.36220472441, 5120.7951681933055, 5213.869653258699, 5245.344331958505, 5272.024675435056, 112545.43727281311, 115571.0, 120120.0, 120887.0, 121205.0, 99619.0, 100294.49852750689, 100440.49779751054, 100571.0, 101659.0, 88646.0, 89041.55479222562, 90591.09408905958, 91185.54407227921, 91574.54212729027, 10092.747681308027, 10163.288569800043, 10205.438700871524, 10221.43782091992, 10235.283530152818, 52145.7392713034, 52884.206736899745, 53860.46139538711, 54147.458525415816, 56158.43841561532, 53863.730681346344, 79654.601726991, 80027.1997280043, 80934.595327023, 81549.59225204073, 14034.578962631138, 14181.929090354482, 14485.493007744679, 14501.274936252934, 14636.634084147981, 15230.466933657712, 15393.076415415111, 15431.228438578251, 15845.683086337978, 16858.494245172664, 14470.855291446951, 14932.402703891723, 15472.613184670474, 15874.365025398854, 16080.919595401949, 13098.607041788762, 13135.0, 13736.450541978209, 14392.856071439151, 15203.239838008276, 13179.0, 13269.469221231042, 13414.597562073153, 13453.529126480526, 13715.519956801463, 10436.63471778484, 10567.682969510926, 10868.782624347627, 10944.78110437771, 10959.945200273947, 11798.11514136426, 11827.70430739204, 11988.580399685969, 12036.217645852992, 12039.518419263131], "value": 7945.360636269142, "unit": "score"}], "name": "dromaeo_css", "value": 7483.187439442085, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 109.0, 109.0, 110.0, 108.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 124.0, 174.0, 126.0, 124.0, 148.0, 126.0, 153.0, 127.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 160.0, 162.0, 163.0, 160.0, 163.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 122.0, 77.0, 76.0, 74.0, 74.0, 106.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 84.0, 84.0, 84.0, 116.0, 85.0, 85.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 54.0, 52.0, 52.0, 64.0, 51.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 82.0, 82.0, 76.0, 83.0, 78.0, 76.0, 107.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 120.0, 127.0, 115.0, 113.0, 116.0, 121.0, 132.0, 127.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 155.0, 160.0, 149.0, 150.0, 149.0, 150.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 64.0, 62.0, 62.0, 60.0, 59.0, 61.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1475.1000000000001, "alertThreshold": 2.0}]} 13:43:38 INFO - Return code: 0 13:43:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:43:38 ERROR - # TBPL SUCCESS # 13:43:38 INFO - Running post-action listener: _resource_record_post_action 13:43:38 INFO - ##### 13:43:38 INFO - ##### Finished run-tests step (success) 13:43:38 INFO - ##### 13:43:38 INFO - Running post-run listener: _resource_record_post_run 13:43:38 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 506494976; Read time: 56; Write time: 531380 13:43:38 INFO - TinderboxPrint: CPU usage
13.1% 13:43:38 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 56 13:43:38 INFO - TinderboxPrint: I/O write bytes / time
506,494,976 / 531,380 13:43:38 INFO - TinderboxPrint: CPU idle
8,254.2 (86.9%) 13:43:38 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 13:43:38 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:38 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252366848; Read time: 0; Write time: 364760 13:43:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253542400; Read time: 36; Write time: 166600 13:43:39 INFO - Running post-run listener: _upload_blobber_files 13:43:39 INFO - Blob upload gear active. 13:43:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:39 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 13:43:39 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:43:39 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:43:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:47 INFO - (blobuploader) - INFO - Done attempting. 13:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:48 INFO - (blobuploader) - INFO - Done attempting. 13:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:49 INFO - (blobuploader) - INFO - Done attempting. 13:43:49 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:49 INFO - Return code: 0 13:43:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4cbcf722a87e07bad99eee1ab2c0cfdf232745995caee230e6c3b3080586b15b643b398c38a9215eb4a174e8a11581ee051b88f8ad1afea99da5a48f24b43c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62e882392a1125626df4d3cc9169ca627baac572f4f1c55305dc01bc5763af06710fe51f9e5897f994042e88a6dad1234b09d532f20fa8be599ca9a224cdd00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea514b28f2aacb106dbb8626bb849e573bd736b2d2c9af483f4eff2d7fbf451ea27aa133b610c530a9f05c68bfd219833f35885cdb7ea9ccf7c9e157e88a1694"} 13:43:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:49 INFO - Contents: 13:43:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4cbcf722a87e07bad99eee1ab2c0cfdf232745995caee230e6c3b3080586b15b643b398c38a9215eb4a174e8a11581ee051b88f8ad1afea99da5a48f24b43c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62e882392a1125626df4d3cc9169ca627baac572f4f1c55305dc01bc5763af06710fe51f9e5897f994042e88a6dad1234b09d532f20fa8be599ca9a224cdd00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea514b28f2aacb106dbb8626bb849e573bd736b2d2c9af483f4eff2d7fbf451ea27aa133b610c530a9f05c68bfd219833f35885cdb7ea9ccf7c9e157e88a1694"} 13:43:49 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:49 INFO - Copying logs to upload dir... 13:43:49 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.973219 ========= master_lag: 2.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-19 13:43:50.764154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 13:43:50.767944) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4cbcf722a87e07bad99eee1ab2c0cfdf232745995caee230e6c3b3080586b15b643b398c38a9215eb4a174e8a11581ee051b88f8ad1afea99da5a48f24b43c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62e882392a1125626df4d3cc9169ca627baac572f4f1c55305dc01bc5763af06710fe51f9e5897f994042e88a6dad1234b09d532f20fa8be599ca9a224cdd00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea514b28f2aacb106dbb8626bb849e573bd736b2d2c9af483f4eff2d7fbf451ea27aa133b610c530a9f05c68bfd219833f35885cdb7ea9ccf7c9e157e88a1694"} build_url:https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/VRY6NgFKRci9hvkOR_m-Ag/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4cbcf722a87e07bad99eee1ab2c0cfdf232745995caee230e6c3b3080586b15b643b398c38a9215eb4a174e8a11581ee051b88f8ad1afea99da5a48f24b43c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62e882392a1125626df4d3cc9169ca627baac572f4f1c55305dc01bc5763af06710fe51f9e5897f994042e88a6dad1234b09d532f20fa8be599ca9a224cdd00e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea514b28f2aacb106dbb8626bb849e573bd736b2d2c9af483f4eff2d7fbf451ea27aa133b610c530a9f05c68bfd219833f35885cdb7ea9ccf7c9e157e88a1694"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 13:43:50.793780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:43:50.794137) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468958202.675941-1590656809 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 13:43:50.844442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 13:43:50.844757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 13:43:50.982153) ========= ========= Total master_lag: 2.92 =========