builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1466301805.74 results: success (0) buildid: 20160618163005 builduid: 057434cb52494a9aa4510c39f94f4d6d revision: ea578e2813f422d30631ef8dd27c8763ec8bad37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.739608) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.740058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.740394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.773065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.773369) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 19:03:25-- 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% 25.7M=0s 2016-06-18 19:03:26 (25.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.885486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.885820) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023180 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:25.937074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 19:03:25.937422) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ea578e2813f422d30631ef8dd27c8763ec8bad37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ea578e2813f422d30631ef8dd27c8763ec8bad37 --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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 19:03:26,120 truncating revision to first 12 chars 2016-06-18 19:03:26,121 Setting DEBUG logging. 2016-06-18 19:03:26,121 attempt 1/10 2016-06-18 19:03:26,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ea578e2813f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 19:03:27,067 unpacking tar archive at: mozilla-inbound-ea578e2813f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 19:03:27.227349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:27.227717) ========= script_repo_revision: ea578e2813f422d30631ef8dd27c8763ec8bad37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:27.228171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:27.228484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 19:03:27.238459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-18 19:03:27.238855) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:03:27 INFO - MultiFileLogger online at 20160618 19:03:27 in /builds/slave/test 19:03:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:03:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:03:27 INFO - {'append_to_log': False, 19:03:27 INFO - 'base_work_dir': '/builds/slave/test', 19:03:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:03:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:03:27 INFO - 'branch': 'Mozilla-Inbound', 19:03:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:03:27 INFO - 'config_files': ('talos/linux_config.py',), 19:03:27 INFO - 'default_actions': ('clobber', 19:03:27 INFO - 'read-buildbot-config', 19:03:27 INFO - 'download-and-extract', 19:03:27 INFO - 'populate-webroot', 19:03:27 INFO - 'create-virtualenv', 19:03:27 INFO - 'install', 19:03:27 INFO - 'run-tests'), 19:03:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:03:27 INFO - 'download_minidump_stackwalk': True, 19:03:27 INFO - 'download_symbols': 'ondemand', 19:03:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:03:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:03:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:03:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:03:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:03:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:03:27 INFO - 'installer_path': 'installer.exe', 19:03:27 INFO - 'log_level': 'info', 19:03:27 INFO - 'log_name': 'talos', 19:03:27 INFO - 'log_to_console': True, 19:03:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:03:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:03:27 INFO - 'opt_config_files': (), 19:03:27 INFO - 'pip_index': False, 19:03:27 INFO - 'sps_profile': False, 19:03:27 INFO - 'sps_profile_interval': 0, 19:03:27 INFO - 'suite': 'dromaeojs', 19:03:27 INFO - 'system_bits': '32', 19:03:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:03:27 INFO - 'title': 'talos-linux64-ix-060', 19:03:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:03:27 INFO - 'use_talos_json': True, 19:03:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:03:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:03:27 INFO - 'work_dir': 'build'} 19:03:27 INFO - ##### 19:03:27 INFO - ##### Running clobber step. 19:03:27 INFO - ##### 19:03:27 INFO - Running pre-action listener: _resource_record_pre_action 19:03:27 INFO - Running main action method: clobber 19:03:27 INFO - rmtree: /builds/slave/test/build 19:03:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:03:27 INFO - Running post-action listener: _resource_record_post_action 19:03:27 INFO - ##### 19:03:27 INFO - ##### Finished clobber step (success) 19:03:27 INFO - ##### 19:03:27 INFO - ##### 19:03:27 INFO - ##### Running read-buildbot-config step. 19:03:27 INFO - ##### 19:03:27 INFO - Running pre-action listener: _resource_record_pre_action 19:03:27 INFO - Running main action method: read_buildbot_config 19:03:27 INFO - Using buildbot properties: 19:03:27 INFO - { 19:03:27 INFO - "project": "", 19:03:27 INFO - "product": "firefox", 19:03:27 INFO - "script_repo_revision": "production", 19:03:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:03:27 INFO - "repository": "", 19:03:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:03:27 INFO - "buildid": "20160618163005", 19:03:27 INFO - "pgo_build": "True", 19:03:27 INFO - "basedir": "/builds/slave/test", 19:03:27 INFO - "buildnumber": 1129, 19:03:27 INFO - "slavename": "talos-linux64-ix-060", 19:03:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:03:27 INFO - "platform": "ubuntu64_hw", 19:03:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:03:27 INFO - "branch": "mozilla-inbound", 19:03:27 INFO - "repo_path": "integration/mozilla-inbound", 19:03:27 INFO - "revision": "ea578e2813f422d30631ef8dd27c8763ec8bad37", 19:03:27 INFO - "stage_platform": "linux64-pgo", 19:03:27 INFO - "builduid": "057434cb52494a9aa4510c39f94f4d6d", 19:03:27 INFO - "slavebuilddir": "test" 19:03:27 INFO - } 19:03:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:03:27 INFO - Running post-action listener: _resource_record_post_action 19:03:27 INFO - ##### 19:03:27 INFO - ##### Finished read-buildbot-config step (success) 19:03:27 INFO - ##### 19:03:27 INFO - ##### 19:03:27 INFO - ##### Running download-and-extract step. 19:03:27 INFO - ##### 19:03:27 INFO - Running pre-action listener: _resource_record_pre_action 19:03:27 INFO - Running main action method: download_and_extract 19:03:27 INFO - mkdir: /builds/slave/test/build/tests 19:03:27 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')]} 19:03:27 INFO - https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:03:29 INFO - Downloaded 1361 bytes. 19:03:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:29 INFO - Using the following test package requirements: 19:03:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:03:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:03:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:03:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'jsshell-linux-x86_64.zip'], 19:03:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:03:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:03:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:03:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:03:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:03:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:03:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:03:29 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')]} 19:03:29 INFO - https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:31 INFO - Downloaded 24221045 bytes. 19:03:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:33 INFO - Return code: 0 19:03:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:03: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')]} 19:03:33 INFO - https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:36 INFO - Downloaded 24221045 bytes. 19:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:37 INFO - Return code: 0 19:03: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')]} 19:03:37 INFO - https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:03:39 INFO - Downloaded 14405384 bytes. 19:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:03:39 INFO - Return code: 0 19:03:39 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')]} 19:03:39 INFO - https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:03:42 INFO - Downloaded 60119888 bytes. 19:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:42 INFO - mkdir: /builds/slave/test/properties 19:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:03:42 INFO - Writing to file /builds/slave/test/properties/build_url 19:03:42 INFO - Contents: 19:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:42 INFO - Running post-action listener: _resource_record_post_action 19:03:42 INFO - Running post-action listener: set_extra_try_arguments 19:03:42 INFO - ##### 19:03:42 INFO - ##### Finished download-and-extract step (success) 19:03:42 INFO - ##### 19:03:42 INFO - ##### 19:03:42 INFO - ##### Running populate-webroot step. 19:03:42 INFO - ##### 19:03:42 INFO - Running pre-action listener: _resource_record_pre_action 19:03:42 INFO - Running main action method: populate_webroot 19:03:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:03:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:03:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:03:42 INFO - '--tppagecycles', 19:03:42 INFO - '7'], 19:03:42 INFO - 'tests': ['tsvgm']}}, 19:03:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:03:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:03:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:03:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:03:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['damp', 'tps']}, 19:03:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'tests': ['damp', 'tps']}, 19:03:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['dromaeo_dom']}, 19:03:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:03:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['basic_compositor_video']}, 19:03:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:03:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'other-e10s': {'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['a11yr', 19:03:42 INFO - 'ts_paint', 19:03:42 INFO - 'tpaint', 19:03:42 INFO - 'sessionrestore', 19:03:42 INFO - 'sessionrestore_no_auto_restore', 19:03:42 INFO - 'tabpaint']}, 19:03:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['tsvgx', 19:03:42 INFO - 'tsvgr_opacity', 19:03:42 INFO - 'tart', 19:03:42 INFO - 'tscrollx', 19:03:42 INFO - 'cart']}, 19:03:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:03:42 INFO - 'tsvgr_opacity', 19:03:42 INFO - 'tart', 19:03:42 INFO - 'tscrollx', 19:03:42 INFO - 'cart']}, 19:03:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'talos_options': ['--disable-e10s'], 19:03:42 INFO - 'tests': ['tp5o']}, 19:03:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'tests': ['tp5o']}, 19:03:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'talos_options': ['--disable-e10s', 19:03:42 INFO - '--xperf_path', 19:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:42 INFO - 'tests': ['tp5n']}, 19:03:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:42 INFO - 'talos_options': ['--xperf_path', 19:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:42 INFO - 'tests': ['tp5n']}}, 19:03:42 INFO - 'talos.zip': {'path': '', 19:03:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:03:42 INFO - Running post-action listener: _resource_record_post_action 19:03:42 INFO - ##### 19:03:42 INFO - ##### Finished populate-webroot step (success) 19:03:42 INFO - ##### 19:03:42 INFO - ##### 19:03:42 INFO - ##### Running create-virtualenv step. 19:03:42 INFO - ##### 19:03:42 INFO - Running pre-action listener: _resource_record_pre_action 19:03:42 INFO - Running main action method: create_virtualenv 19:03:42 INFO - Creating virtualenv /builds/slave/test/build/venv 19:03:42 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 19:03:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:03:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:03:42 INFO - Using real prefix '/usr' 19:03:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:03:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:03:45 INFO - Installing pip.................done. 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:03:45 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')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 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')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:45 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 19:03:45 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 19:03:45 INFO - Using env: {'DISPLAY': ':0', 19:03:45 INFO - 'HOME': '/home/cltbld', 19:03:45 INFO - 'LANG': 'en_US.UTF-8', 19:03:45 INFO - 'LANGUAGE': 'en_US:en', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MAIL': '/var/mail/cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SHLVL': '1', 19:03:45 INFO - 'TERM': 'linux', 19:03:45 INFO - 'TMOUT': '86400', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - '_': '/tools/buildbot/bin/python'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 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 19:03:45 INFO - Cleaning up... 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:03:45 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')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 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')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:45 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 19:03:45 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 19:03:45 INFO - Using env: {'DISPLAY': ':0', 19:03:45 INFO - 'HOME': '/home/cltbld', 19:03:45 INFO - 'LANG': 'en_US.UTF-8', 19:03:45 INFO - 'LANGUAGE': 'en_US:en', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MAIL': '/var/mail/cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SHLVL': '1', 19:03:45 INFO - 'TERM': 'linux', 19:03:45 INFO - 'TMOUT': '86400', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - '_': '/tools/buildbot/bin/python'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 INFO - Downloading/unpacking psutil>=3.1.1 19:03:45 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 19:03:45 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 19:03:45 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 19:03:45 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 19:03:45 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 19:03:45 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 19:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:47 INFO - Installing collected packages: psutil 19:03:47 INFO - Running setup.py install for psutil 19:03:47 INFO - building 'psutil._psutil_linux' extension 19:03:47 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 19:03:48 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 19:03:48 INFO - building 'psutil._psutil_posix' extension 19:03:48 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 19:03:48 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 19:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:48 INFO - Successfully installed psutil 19:03:48 INFO - Cleaning up... 19:03:48 INFO - Return code: 0 19:03:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:48 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:48 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 19:03:48 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 19:03:48 INFO - Using env: {'DISPLAY': ':0', 19:03:48 INFO - 'HOME': '/home/cltbld', 19:03:48 INFO - 'LANG': 'en_US.UTF-8', 19:03:48 INFO - 'LANGUAGE': 'en_US:en', 19:03:48 INFO - 'LOGNAME': 'cltbld', 19:03:48 INFO - 'MAIL': '/var/mail/cltbld', 19:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:48 INFO - 'MOZ_NO_REMOTE': '1', 19:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:48 INFO - 'NO_EM_RESTART': '1', 19:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:48 INFO - 'PWD': '/builds/slave/test', 19:03:48 INFO - 'SHELL': '/bin/bash', 19:03:48 INFO - 'SHLVL': '1', 19:03:48 INFO - 'TERM': 'linux', 19:03:48 INFO - 'TMOUT': '86400', 19:03:48 INFO - 'USER': 'cltbld', 19:03:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:48 INFO - '_': '/tools/buildbot/bin/python'} 19:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:03:48 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 19:03:48 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 19:03:48 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 19:03:48 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 19:03:48 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 19:03:48 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 19:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:03:50 INFO - Installing collected packages: mozsystemmonitor 19:03:50 INFO - Running setup.py install for mozsystemmonitor 19:03:50 INFO - Successfully installed mozsystemmonitor 19:03:50 INFO - Cleaning up... 19:03:50 INFO - Return code: 0 19:03:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:03:50 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')]} 19:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:50 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')]} 19:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:50 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:50 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 19:03:50 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 19:03:50 INFO - Using env: {'DISPLAY': ':0', 19:03:50 INFO - 'HOME': '/home/cltbld', 19:03:50 INFO - 'LANG': 'en_US.UTF-8', 19:03:50 INFO - 'LANGUAGE': 'en_US:en', 19:03:50 INFO - 'LOGNAME': 'cltbld', 19:03:50 INFO - 'MAIL': '/var/mail/cltbld', 19:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:50 INFO - 'MOZ_NO_REMOTE': '1', 19:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:50 INFO - 'NO_EM_RESTART': '1', 19:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:50 INFO - 'PWD': '/builds/slave/test', 19:03:50 INFO - 'SHELL': '/bin/bash', 19:03:50 INFO - 'SHLVL': '1', 19:03:50 INFO - 'TERM': 'linux', 19:03:50 INFO - 'TMOUT': '86400', 19:03:50 INFO - 'USER': 'cltbld', 19:03:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:50 INFO - '_': '/tools/buildbot/bin/python'} 19:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:50 INFO - Downloading/unpacking jsonschema==2.5.1 19:03:50 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 19:03:50 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 19:03:50 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 19:03:50 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 19:03:50 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 19:03:50 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 19:03:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:52 INFO - warning: no files found matching '*.txt' 19:03:52 INFO - no previously-included directories found matching 'build' 19:03:52 INFO - no previously-included directories found matching 'dist' 19:03:52 INFO - no previously-included directories found matching '.git*' 19:03:52 INFO - Installing collected packages: jsonschema, functools32 19:03:53 INFO - Running setup.py install for functools32 19:03:53 INFO - warning: no files found matching '*.txt' 19:03:53 INFO - no previously-included directories found matching 'build' 19:03:53 INFO - no previously-included directories found matching 'dist' 19:03:53 INFO - no previously-included directories found matching '.git*' 19:03:53 INFO - Successfully installed jsonschema functools32 19:03:53 INFO - Cleaning up... 19:03:53 INFO - Return code: 0 19:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:03:53 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')]} 19:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:53 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')]} 19:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:53 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:53 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 19:03:53 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 19:03:53 INFO - Using env: {'DISPLAY': ':0', 19:03:53 INFO - 'HOME': '/home/cltbld', 19:03:53 INFO - 'LANG': 'en_US.UTF-8', 19:03:53 INFO - 'LANGUAGE': 'en_US:en', 19:03:53 INFO - 'LOGNAME': 'cltbld', 19:03:53 INFO - 'MAIL': '/var/mail/cltbld', 19:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:53 INFO - 'MOZ_NO_REMOTE': '1', 19:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:53 INFO - 'NO_EM_RESTART': '1', 19:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:53 INFO - 'PWD': '/builds/slave/test', 19:03:53 INFO - 'SHELL': '/bin/bash', 19:03:53 INFO - 'SHLVL': '1', 19:03:53 INFO - 'TERM': 'linux', 19:03:53 INFO - 'TMOUT': '86400', 19:03:53 INFO - 'USER': 'cltbld', 19:03:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:53 INFO - '_': '/tools/buildbot/bin/python'} 19:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:03:53 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 19:03:53 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 19:03:53 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 19:03:53 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 19:03:53 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 19:03:53 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 19:03:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 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 19:03:55 INFO - Downloading docopt-0.6.1.tar.gz 19:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:56 INFO - Running setup.py install for blobuploader 19:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:56 INFO - Running setup.py install for requests 19:03:56 INFO - Running setup.py install for docopt 19:03:56 INFO - Successfully installed blobuploader requests docopt 19:03:56 INFO - Cleaning up... 19:03:56 INFO - Return code: 0 19:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:56 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:56 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 19:03:56 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 19:03:56 INFO - Using env: {'DISPLAY': ':0', 19:03:56 INFO - 'HOME': '/home/cltbld', 19:03:56 INFO - 'LANG': 'en_US.UTF-8', 19:03:56 INFO - 'LANGUAGE': 'en_US:en', 19:03:56 INFO - 'LOGNAME': 'cltbld', 19:03:56 INFO - 'MAIL': '/var/mail/cltbld', 19:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:56 INFO - 'MOZ_NO_REMOTE': '1', 19:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:56 INFO - 'NO_EM_RESTART': '1', 19:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:56 INFO - 'PWD': '/builds/slave/test', 19:03:56 INFO - 'SHELL': '/bin/bash', 19:03:56 INFO - 'SHLVL': '1', 19:03:56 INFO - 'TERM': 'linux', 19:03:56 INFO - 'TMOUT': '86400', 19:03:56 INFO - 'USER': 'cltbld', 19:03:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:56 INFO - '_': '/tools/buildbot/bin/python'} 19:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:56 INFO - Running setup.py (path:/tmp/pip-aT0Okn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:56 INFO - Running setup.py (path:/tmp/pip-HP014T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:57 INFO - Running setup.py (path:/tmp/pip-HcqJLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:57 INFO - Running setup.py (path:/tmp/pip-Bf0Qhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:57 INFO - Running setup.py (path:/tmp/pip-70wBzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:57 INFO - Running setup.py (path:/tmp/pip-KPmAjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:57 INFO - Running setup.py (path:/tmp/pip-tYNXkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:57 INFO - Running setup.py (path:/tmp/pip-yIOh00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:57 INFO - Running setup.py (path:/tmp/pip-xMOpcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:57 INFO - Running setup.py (path:/tmp/pip-4WKteq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:57 INFO - Running setup.py (path:/tmp/pip-CPGDud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:57 INFO - Running setup.py (path:/tmp/pip-Xv5fZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:57 INFO - Running setup.py (path:/tmp/pip-_IlNJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:57 INFO - Running setup.py (path:/tmp/pip-NOYIpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:57 INFO - Running setup.py (path:/tmp/pip-nNUgnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:57 INFO - Running setup.py (path:/tmp/pip-v1RnrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:58 INFO - Running setup.py (path:/tmp/pip-011jTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:58 INFO - Running setup.py install for manifestparser 19:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Running setup.py install for mozcrash 19:03:58 INFO - Running setup.py install for mozdebug 19:03:58 INFO - Running setup.py install for mozdevice 19:03:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Running setup.py install for mozfile 19:03:58 INFO - Running setup.py install for mozhttpd 19:03:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Running setup.py install for mozinfo 19:03:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Running setup.py install for mozInstall 19:03:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:58 INFO - Running setup.py install for mozleak 19:03:58 INFO - Running setup.py install for mozlog 19:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Running setup.py install for moznetwork 19:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Running setup.py install for mozprocess 19:03:59 INFO - Running setup.py install for mozprofile 19:03:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Running setup.py install for mozrunner 19:03:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Running setup.py install for mozscreenshot 19:03:59 INFO - Running setup.py install for moztest 19:03:59 INFO - Running setup.py install for mozversion 19:03:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:59 INFO - Cleaning up... 19:03:59 INFO - Return code: 0 19:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:59 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:03:59 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 19:03:59 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 19:03:59 INFO - Using env: {'DISPLAY': ':0', 19:03:59 INFO - 'HOME': '/home/cltbld', 19:03:59 INFO - 'LANG': 'en_US.UTF-8', 19:03:59 INFO - 'LANGUAGE': 'en_US:en', 19:03:59 INFO - 'LOGNAME': 'cltbld', 19:03:59 INFO - 'MAIL': '/var/mail/cltbld', 19:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:59 INFO - 'MOZ_NO_REMOTE': '1', 19:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:59 INFO - 'NO_EM_RESTART': '1', 19:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:59 INFO - 'PWD': '/builds/slave/test', 19:03:59 INFO - 'SHELL': '/bin/bash', 19:03:59 INFO - 'SHLVL': '1', 19:03:59 INFO - 'TERM': 'linux', 19:03:59 INFO - 'TMOUT': '86400', 19:03:59 INFO - 'USER': 'cltbld', 19:03:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:59 INFO - '_': '/tools/buildbot/bin/python'} 19:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:00 INFO - Running setup.py (path:/tmp/pip-T3aP7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:00 INFO - Running setup.py (path:/tmp/pip-NaIG6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:00 INFO - Running setup.py (path:/tmp/pip-NZwviu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:00 INFO - Running setup.py (path:/tmp/pip-dO9l0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:00 INFO - Running setup.py (path:/tmp/pip-Eku_k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:00 INFO - Running setup.py (path:/tmp/pip-mGFFwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:00 INFO - Running setup.py (path:/tmp/pip-JuNYbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:00 INFO - Running setup.py (path:/tmp/pip-md2huf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:00 INFO - Running setup.py (path:/tmp/pip-o3tit_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:00 INFO - Running setup.py (path:/tmp/pip-bFqllr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:00 INFO - Running setup.py (path:/tmp/pip-U4vGTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:00 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)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:00 INFO - Running setup.py (path:/tmp/pip-omzNNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:00 INFO - Running setup.py (path:/tmp/pip-UsBokt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:01 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)) 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:01 INFO - Running setup.py (path:/tmp/pip-8ylkWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:01 INFO - Running setup.py (path:/tmp/pip-iFVYZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:01 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)) 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:01 INFO - Running setup.py (path:/tmp/pip-dVHImk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:01 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)) 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:01 INFO - Running setup.py (path:/tmp/pip-sqEkbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:01 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)) 19:04:01 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)) 19:04:01 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)) 19:04:01 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)) 19:04:01 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)) 19:04:01 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)) 19:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:04:01 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 19:04:01 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 19:04:01 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 19:04:01 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 19:04:01 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 19:04:01 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 19:04:03 INFO - Downloading blessings-1.6.tar.gz 19:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:04:03 INFO - Installing collected packages: blessings 19:04:03 INFO - Running setup.py install for blessings 19:04:03 INFO - Successfully installed blessings 19:04:03 INFO - Cleaning up... 19:04:03 INFO - Return code: 0 19:04:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:03 INFO - Reading from file tmpfile_stdout 19:04:03 INFO - Current package versions: 19:04:03 INFO - argparse == 1.2.1 19:04:03 INFO - blessings == 1.6 19:04:03 INFO - blobuploader == 1.2.4 19:04:03 INFO - docopt == 0.6.1 19:04:03 INFO - functools32 == 3.2.3-2 19:04:03 INFO - jsonschema == 2.5.1 19:04:03 INFO - manifestparser == 1.1 19:04:03 INFO - mozInstall == 1.12 19:04:03 INFO - mozcrash == 0.17 19:04:03 INFO - mozdebug == 0.1 19:04:03 INFO - mozdevice == 0.48 19:04:03 INFO - mozfile == 1.2 19:04:03 INFO - mozhttpd == 0.7 19:04:03 INFO - mozinfo == 0.9 19:04:03 INFO - mozleak == 0.1 19:04:03 INFO - mozlog == 3.2 19:04:03 INFO - moznetwork == 0.27 19:04:03 INFO - mozprocess == 0.22 19:04:03 INFO - mozprofile == 0.28 19:04:03 INFO - mozrunner == 6.11 19:04:03 INFO - mozscreenshot == 0.1 19:04:03 INFO - mozsystemmonitor == 0.3 19:04:03 INFO - moztest == 0.7 19:04:03 INFO - mozversion == 1.4 19:04:03 INFO - psutil == 3.1.1 19:04:03 INFO - requests == 1.2.3 19:04:03 INFO - wsgiref == 0.1.2 19:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04: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')]} 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:03 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:04:03 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 19:04:03 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 19:04:03 INFO - Using env: {'DISPLAY': ':0', 19:04:03 INFO - 'HOME': '/home/cltbld', 19:04:03 INFO - 'LANG': 'en_US.UTF-8', 19:04:03 INFO - 'LANGUAGE': 'en_US:en', 19:04:03 INFO - 'LOGNAME': 'cltbld', 19:04:03 INFO - 'MAIL': '/var/mail/cltbld', 19:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:03 INFO - 'MOZ_NO_REMOTE': '1', 19:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:03 INFO - 'NO_EM_RESTART': '1', 19:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:03 INFO - 'PWD': '/builds/slave/test', 19:04:03 INFO - 'SHELL': '/bin/bash', 19:04:03 INFO - 'SHLVL': '1', 19:04:03 INFO - 'TERM': 'linux', 19:04:03 INFO - 'TMOUT': '86400', 19:04:03 INFO - 'USER': 'cltbld', 19:04:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:03 INFO - '_': '/tools/buildbot/bin/python'} 19:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 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)) 19:04:03 INFO - Cleaning up... 19:04:03 INFO - Return code: 0 19:04:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:04: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')]} 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:04:03 INFO - Using env: {'DISPLAY': ':0', 19:04:03 INFO - 'HOME': '/home/cltbld', 19:04:03 INFO - 'LANG': 'en_US.UTF-8', 19:04:03 INFO - 'LANGUAGE': 'en_US:en', 19:04:03 INFO - 'LOGNAME': 'cltbld', 19:04:03 INFO - 'MAIL': '/var/mail/cltbld', 19:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:03 INFO - 'MOZ_NO_REMOTE': '1', 19:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:03 INFO - 'NO_EM_RESTART': '1', 19:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:03 INFO - 'PWD': '/builds/slave/test', 19:04:03 INFO - 'SHELL': '/bin/bash', 19:04:03 INFO - 'SHLVL': '1', 19:04:03 INFO - 'TERM': 'linux', 19:04:03 INFO - 'TMOUT': '86400', 19:04:03 INFO - 'USER': 'cltbld', 19:04:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:03 INFO - '_': '/tools/buildbot/bin/python'} 19:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:04:04 INFO - Cleaning up... 19:04:04 INFO - Return code: 0 19:04:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:04: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')]} 19:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:04 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 0x7f9e4f0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1271350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, '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': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', '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 19:04:04 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 19:04:04 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 19:04:04 INFO - Using env: {'DISPLAY': ':0', 19:04:04 INFO - 'HOME': '/home/cltbld', 19:04:04 INFO - 'LANG': 'en_US.UTF-8', 19:04:04 INFO - 'LANGUAGE': 'en_US:en', 19:04:04 INFO - 'LOGNAME': 'cltbld', 19:04:04 INFO - 'MAIL': '/var/mail/cltbld', 19:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:04 INFO - 'MOZ_NO_REMOTE': '1', 19:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:04 INFO - 'NO_EM_RESTART': '1', 19:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:04 INFO - 'PWD': '/builds/slave/test', 19:04:04 INFO - 'SHELL': '/bin/bash', 19:04:04 INFO - 'SHLVL': '1', 19:04:04 INFO - 'TERM': 'linux', 19:04:04 INFO - 'TMOUT': '86400', 19:04:04 INFO - 'USER': 'cltbld', 19:04:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:04 INFO - '_': '/tools/buildbot/bin/python'} 19:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:04 INFO - Downloading/unpacking flake8 19:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:04:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:04:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:04:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:06 INFO - no previously-included directories found matching 'docs/_build' 19:04:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:04:07 INFO - Running setup.py install for pep8 19:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:07 INFO - no previously-included directories found matching 'docs/_build' 19:04:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:04:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:04:07 INFO - Cleaning up... 19:04:07 INFO - Return code: 0 19:04:07 INFO - Running post-action listener: _resource_record_post_action 19:04:07 INFO - Running post-action listener: _start_resource_monitoring 19:04:07 INFO - Starting resource monitoring. 19:04:07 INFO - ##### 19:04:07 INFO - ##### Finished create-virtualenv step (success) 19:04:07 INFO - ##### 19:04:07 INFO - ##### 19:04:07 INFO - ##### Running install step. 19:04:07 INFO - ##### 19:04:07 INFO - Running pre-action listener: _resource_record_pre_action 19:04:07 INFO - Running main action method: install 19:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:07 INFO - Reading from file tmpfile_stdout 19:04:07 INFO - Detecting whether we're running mozinstall >=1.0... 19:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:04:07 INFO - Reading from file tmpfile_stdout 19:04:07 INFO - Output received: 19:04:07 INFO - Usage: mozinstall [options] installer 19:04:07 INFO - Options: 19:04:07 INFO - -h, --help show this help message and exit 19:04:07 INFO - -d DEST, --destination=DEST 19:04:07 INFO - Directory to install application into. [default: 19:04:07 INFO - "/builds/slave/test"] 19:04:07 INFO - --app=APP Application being installed. [default: firefox] 19:04:07 INFO - mkdir: /builds/slave/test/build/application 19:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:04:24 INFO - Reading from file tmpfile_stdout 19:04:24 INFO - Output received: 19:04:24 INFO - /builds/slave/test/build/application/firefox/firefox 19:04:24 INFO - Running post-action listener: _resource_record_post_action 19:04:24 INFO - ##### 19:04:24 INFO - ##### Finished install step (success) 19:04:24 INFO - ##### 19:04:24 INFO - ##### 19:04:24 INFO - ##### Running run-tests step. 19:04:24 INFO - ##### 19:04:24 INFO - Running pre-action listener: _resource_record_pre_action 19:04:24 INFO - Running main action method: run_tests 19:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:04:24 INFO - Python 2.7.3 19:04:24 INFO - Return code: 0 19:04:24 INFO - grabbing minidump binary from tooltool 19:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:24 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 0x13001c0>, '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 0x13010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1301550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:04:24 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 19:04:24 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 19:04:24 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 19:04:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:04:24 INFO - Return code: 0 19:04:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:04:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:04:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:04:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:04:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:04:25 INFO - Return code: 0 19:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 19:04:25 INFO - Using env: {'DISPLAY': ':0', 19:04:25 INFO - 'HOME': '/home/cltbld', 19:04:25 INFO - 'LANG': 'en_US.UTF-8', 19:04:25 INFO - 'LANGUAGE': 'en_US:en', 19:04:25 INFO - 'LOGNAME': 'cltbld', 19:04:25 INFO - 'MAIL': '/var/mail/cltbld', 19:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:25 INFO - 'MOZ_NO_REMOTE': '1', 19:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:25 INFO - 'NO_EM_RESTART': '1', 19:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:25 INFO - 'PWD': '/builds/slave/test', 19:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:04:25 INFO - 'SHELL': '/bin/bash', 19:04:25 INFO - 'SHLVL': '1', 19:04:25 INFO - 'TERM': 'linux', 19:04:25 INFO - 'TMOUT': '86400', 19:04:25 INFO - 'USER': 'cltbld', 19:04:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660', 19:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:25 INFO - '_': '/tools/buildbot/bin/python'} 19:04:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:04:25 INFO - mozversion application_buildid: 20160618163005 19:04:25 INFO - mozversion application_changeset: ea578e2813f422d30631ef8dd27c8763ec8bad37 19:04:25 INFO - mozversion application_display_name: Nightly 19:04:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:04:25 INFO - mozversion application_name: Firefox 19:04:25 INFO - mozversion application_remotingname: firefox 19:04:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:04:25 INFO - mozversion application_vendor: Mozilla 19:04:25 INFO - mozversion application_version: 50.0a1 19:04:25 INFO - mozversion platform_buildid: 20160618163005 19:04:25 INFO - mozversion platform_changeset: ea578e2813f422d30631ef8dd27c8763ec8bad37 19:04:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:04:25 INFO - mozversion platform_version: 50.0a1 19:04:25 INFO - using testdate: 1466301865 19:04:25 INFO - actual date: 1466301865 19:04:25 INFO - starting webserver on 'localhost:48630' 19:04:25 INFO - SUITE-START | Running 2 tests 19:04:25 INFO - TEST-START | dromaeo_css 19:04:25 INFO - operating with platform_type : linux_ 19:04:25 INFO - Initialising browser for dromaeo_css test... 19:04:25 INFO - TEST-INFO | started process 14644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHfMgk/profile http://localhost:48630/getInfo.html) 19:04:29 INFO - PROCESS | 14644 | __metrics Screen width/height:1600/1200 19:04:29 INFO - PROCESS | 14644 | colorDepth:24 19:04:29 INFO - PROCESS | 14644 | Browser inner width/height: 1024/697 19:04:29 INFO - PROCESS | 14644 | __metrics 19:04:30 INFO - PROCESS | 14644 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:31 INFO - TEST-INFO | 14644: exit 0 19:04:31 INFO - Browser initialized. 19:04:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:04:31 INFO - TEST-INFO | started process 14726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHfMgk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:43 INFO - PROCESS | 14726 | RSS: Main: 173883392 19:04:43 INFO - PROCESS | 14726 | 19:05:35 INFO - PROCESS | 14726 | 1466301935440 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] 19:07:43 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48630/tests/dromaeo/cssquery-ext.html) 19:07:44 INFO - PROCESS | 14726 | RSS: Main: 262021120 19:07:44 INFO - PROCESS | 14726 | 19:10:46 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-ext.html (next: http://localhost:48630/tests/dromaeo/cssquery-jquery.html) 19:10:47 INFO - PROCESS | 14726 | RSS: Main: 257499136 19:10:47 INFO - PROCESS | 14726 | 19:13:49 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48630/tests/dromaeo/cssquery-mootools.html) 19:13:49 INFO - PROCESS | 14726 | RSS: Main: 258367488 19:13:49 INFO - PROCESS | 14726 | 19:16:51 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48630/tests/dromaeo/cssquery-prototype.html) 19:16:52 INFO - PROCESS | 14726 | RSS: Main: 252686336 19:16:52 INFO - PROCESS | 14726 | 19:19:54 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48630/tests/dromaeo/cssquery-yui.html) 19:19:55 INFO - PROCESS | 14726 | RSS: Main: 221097984 19:19:55 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-yui.html (next: http://localhost:48630/tests/dromaeo/cssquery-dojo.html) 19:22:58 INFO - PROCESS | 14726 | RSS: Main: 305217536 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | __start_tp_report 19:22:58 INFO - PROCESS | 14726 | _x_x_mozilla_page_load 19:22:58 INFO - PROCESS | 14726 | _x_x_mozilla_page_load_details 19:22:58 INFO - PROCESS | 14726 | |i|pagename|runs| 19:22:58 INFO - PROCESS | 14726 | |0;dojo.html;3093.1184612385473;3101.8604162812658;3129.6870312968704;3148.637906640737;3159.8420078996046;5310.893782124355;5327.387350454699;5403.891922161564;5419.701916394597;5429.56563474922;5313.946860531393;5330.387005494369;5432.103702889019;5481.725913704318;5533.335999680034;4824.565789078983;4840.491748366415;4859.927101093486;4870.147724148278;5008.84973450797;4955.479674634165;4964.900701985958;5006.349174607296;5033.194688849785;5033.270175824503;4795.904081918359;4823.5176482351835;4838.250071238946;4887.169181239198;4974.303597496335;4822.300766388854;4829.275608658694;4830.2513110467935;4926.630502712311;4952.182889823175;4889.75551222441;4896.020795840846;4897.2654101885;4902.681325713817;4913.754312284372;5206.24509446132;5358.973205133989;5389.622726409153;5399.892002159974;5425.511703946624;5850.297964244275;5888;5962.314333851619;5962.582619216657;5964.403559644044;5917.556183286228;5937.109433584954;5977.850553736148;5980.222571065734;5987.670678112702;5312.389075256357;5400.513953744182;5413.621046526745;5428.267183930119;5499.532539734168;5933.6736479493175;5991.580589358703;5996.730147143389;5998.430149135826;6002.069679199731;5458.945410545924;5778.046622307273;5779.248697669276;5789.88420231593;5796.565257605696;5700.486956173964;5765.04876695349;5769.1634712967225;5828.5337173026055;5836.299644042742;5770.2498675171955;5781.103928891029;5800.941990580124;5801.680907550125;5806.2451881255165;5647.237622920853;5752.827415177551;5784.392638772868;5788.942110578841;5790.913136302959;4450.2434586120435;4485.842995495142;4494.37078808967;4530.343100250445;4533.909321813611;3974.066094467798;3990.86031988879;3991.1219531702977;3998.140399814054;4032.4152997815154;5352.973235133877;5412;5425.213344065089;5538.778448862081;5539.418361072029;5780.682062486603;5804.332501762267;5826.038703613941;5839.065749480063;5852.882942341214;5491.450854914477;5497.917531237034;5500.3949565547755;5509.531689806331;5511.53151982086;4857.684250523705;5027.974860125676;5031.84904452867;5055.039542486989;5080.949190508121;6001.7599296027665;6090.056041313604;6094.561897584374;6106.72519736613;6110.133516259496;5904.3800400959;5912.526997840248;5913.379095194942;5917.201177840936;5917.644941303535;5810.1575271586225;5903.704814759159;5962.046072628359;6043.365446628217;6061.36355682647;5720.456556627114;5761.769529218952;5762.049261871744;5771.163181338767;5813.563982701399;5849.502792262535;5863.501602363847;5872.324682661378;5885.823425297248;5887.646741195542;5486.067368547437;5619.185218143428;5655.830325090254;5686.232358631697;5703.828885133453;5693.202951586864;5707.600467967369;5712.457316554921;5717.42825717425;5719.942800572107;5588.6646801192055;5596.86007849807;5597.832065038056;5598.496135347838;5599.804006859903;5449.427810079885;5650.067738823048;5718.542516598579;5724.484796368347;5809.041508151107;5588.804391846266;5616.410276920865;5623.662580245198;5624.718764061862;5667.574931880208 19:22:58 INFO - PROCESS | 14726 | |1;ext.html;589.3899813692829;601.6029420582415;613.1171113596423;626.30792973764;631.8988961766119;30826.845865770694;42008.57991420085;43065;43140.35289470653;43377.915552111175;44836.77581612096;45105.54894451055;45287.32069018967;45389;45422.77288613561;9023.593938272777;9148.954255228715;9169.220616247627;9175.54122293886;9181.862272065924;8936.910630893673;9049.864252036225;9052.094790520929;9055.547222638874;9058.637654493812;9088.727338179866;9103.681371152012;9109.45343279402;9119.635214591408;9127.771805704877;9055.592498337557;9076.410033347844;9084.545772711337;9104.271658267357;9110.407823491518;8973.10268973104;9036.096390360977;9042.18620324174;9054.773630659287;9055.547222638841;42654.78672606617;43071.35392969108;43135.56864431378;43192.352114718306;43208.56791432077;3609.5127157833617;3859.996400935777;4088.407180958774;4148.02521407469;4395.450568678915;32597;33128.66871331304;33245.33509329824;33257.334853303044;34768;3836.6738827199442;3877.6316249956208;3919.7256192066566;3951.111000025;4003.8798836034966;318349.9999999977;318715;319740;320954;321407;52325;57521.137182942286;58627.41372586305;59127.70436147792;59308;62286.68856655688;62302;62565.68717156385;62915;63287;16138;16302.347906083623;16305.673886522203;16320.286369931224;16354.836451635569;11053.778924421467;12029.759404811855;12266.693332666755;12334.321612311229;12607.495700172074;18169.45491635253;18432.907835460737;18579.349722759638;18587;18639;5959.64242145464;6002.279726432856;6030.366811484819;6141.324454310023;6168.753249870045;916.7708072981754;1042.702829693549;1046.7173863056933;1077.235163034239;1135.381217236608;32119.51820722691;32450.943632045994;32522.349553008808;32702.672973270437;32880.83559582235;1029.4286670897575;1128.0468004536153;1137.3403426012892;1147.552454542729;1194.66443103732;17043.573910652332;18092.185851636707;18124.546886327684;18963.62072758537;19072.90463547701;550873;550945;551587;553814;555380;58632;58674;58740;58770.11844822331;59007;1252.5240408644838;1333.153447560806;1374.4502199120432;1378.269517155889;1390.5341710526884;31742;32931.67068329382;33374.66625333716;33550.83224583862;34076.31847362989;50891;51219;51361;51391.74304128456;51516.48483515117;410341;413148;413159;413335;414495;24805;27278.454430910875;28099.578506322014;28383.29041773972;29795.702042979294;47130.29304560503;47849.521504784505;48516;48930;49092;40492.39261411022;40534;40995.38506922458;41524.79237603793;42216;40839.56170818373;41099;41354.37968430416;41395.379069313385;41693.16613667649;40606;41206.587934121475;41455.1708965825;41488;41563;35733.46399803953;36290.63709362873;36502.62590963626;36875.26249475049;37209.62790372062;28149.394014345784;28232.15303540897;28252.514555335427;28284.575731364457;28410.431791363644 19:22:58 INFO - PROCESS | 14726 | |2;jquery.html;386.85106234099874;389.27011852776064;399.2015968063872;399.9960100148627;418.3682639214787;13988.930055349734;16015.599610009756;17627.471175864728;19218.327358542454;19302.517437064063;13040.869591304085;15254.694906101871;15540.922295388535;17720.379786707468;17729.91135044326;5612.438756124386;5650.378458369576;5707.885842283152;5778.6243894146955;5797.333306669745;3954.960450395488;5725.942740572604;5752.194692742998;5783.855403614902;6088.147659327676;6504.739810407602;6518.902216466757;6607.735690572371;6616.636085015322;6629.171353580802;6516.5112616553715;6579.868402631944;6594.8681026379445;6645.734170633169;6645.93354066458;5682.573806964494;5758.971205143989;5793.797217097382;5799.710014499258;5806.042003069489;22729.204477843363;22890.427739306484;23118.306450806504;23499.060037598476;23579.88210058956;2519.86140762258;2586.456844062749;2593.714691383946;2816.4367126574766;2912.606798082274;14308.28458577067;14345;14638.707225855424;14891.47879824201;15133.697326053527;1998.4704053425853;2022.565148493081;2038.8266997305248;2043.162303455591;2049.897505124738;80090.5995470019;81816;81970.59014704949;82234;82988;9947.651832185838;9978.550965206583;10340.482975851328;10410.323328983592;10519.368837869752;14263.07290026145;14385.136891786526;14395.78406323906;14417.13497190172;14417.78373324401;7025.156981162293;7674;7736.381089512825;7751.7674469766;7827.099883513469;7754.18581048993;7794.883076753853;8080.39397045224;8263.049749278909;8328.875066874001;6656.8668626627195;6670.266270710218;6681.098051763047;6683.2314283857;6836.897446538306;1915.549845786239;1928.4793105861338;1936.7772706138692;1947.7760057593557;2013.7180794688754;884.920357167858;978.1587834462357;995.8904520502739;1021.6883850425543;1080.114306268852;19504.70742938857;19826.50433739168;19846.90076549608;19892.801071989383;19990.800091998895;1008.7377281906757;1025.9487025648689;1060.7613287010515;1067.1889364083352;1077.197487871525;8930.86603700945;11332.830007549728;11456.3698996556;11483.36841473727;11532.423378831192;435960;441538;459613;467556;475131;88702.55648721845;94201.5289923546;94228;94870;95282.52358738301;980.578351308944;1005.1355833982769;1015.9288849780593;1021.8722659667542;1038.963636272742;16851.1574421276;17098.829011710222;17128.828711712722;17370.13149342553;17661.293548257927;32391.67608323981;39030.80484597672;39389.60610393974;40717.59282407138;41607.959801005214;56133;58072.4192758067;58494.12258816036;58611.70694146502;58895.70552147212;7129.750458733919;7497.737579184703;8015;8338.79153021155;8408.537530435884;12366.319852408204;13020.869791301966;13087.541936032574;13100.868991309964;13146.948244140254;10928.50821713009;11303.773924521627;11328.886711132784;11383.829242561535;11437.885621143681;11252.381119038204;11286.717832054264;11296.548138074713;11642.126840486828;11710.12174086964;11458.4270786462;11613.593524226611;11843.822342665038;11868.58459953932;11995.580154694893;7538.623068846646;7719.845603088019;7841.411894108079;7866.8819967701675;7878;9814.607415703293;11583.536658533565;11636.88363116358;11690.70773230676;11829.34938578352 19:22:58 INFO - PROCESS | 14726 | |3;mootools.html;1317.9538716144937;1488.464152904954;1526.1072272720457;1673.5607377655215;1798.5413719501532;8498.745037648865;9007.504587247699;9076.591553380098;9351.6726914558;9381.718548443541;9010.909890901088;9196.0803919608;9213.631454741819;9226.907730922689;9232.584533695983;2068.979310206901;2308.5844547981355;2383.7735415135576;2416.915407960722;2418.8790560471994;2500.6624105745673;2503.5493611149986;2508.147229941819;2509.046562306321;2511.2717311979595;2411.758824117583;2472.4807790364043;2480.3923038855505;2480.4419005723657;2481;2068.152057656361;2295.070496448924;2352.164981431593;2366.5503554324623;2371.193794110011;2365.562370961378;2376.3346263046374;2397.06514459361;2397.2209032064475;2399.8320117591775;9143.725688229364;9223.169914707709;9249.075092490697;9318.906810931872;9389.295802814748;5295.920561191585;5439.401665816757;5448.264484294609;5448.318960129984;5503.724813759296;3345.130266130799;3565.893023209308;3607.9098022549383;3612.5123108380294;3637.963620363789;1151.8675352334506;1164.3828770751516;1180.740237147826;1193.3973343461496;1199.790036743575;13051.086423950423;13080.149790263698;13087.149335293176;13099.279539625317;13104.148230365092;4755.738434386142;4859.514048595112;4938.925916111261;4958.256261560723;4965.131102057126;10837.778255457612;10891.782164356828;10894.564217431373;10901.890981090246;10914.399708016135;5436.0486914790545;5445.210444485607;5446.101393270145;5447.891042179213;5449.4005659377435;4381.759003254851;4850.854474365775;4942.159832828428;4961.975190124026;5043.5460808527405;4093.406456063854;4107.9178416431505;4150.501939767248;4176.686748493875;4201.70588058833;1245.0786418050577;1286.5368467351745;1291.9483220671068;1296.118639325249;1306.9477220911058;892.7321803458937;980.4901451245313;993.6720882108887;995.8058178655093;1014.6499457687086;6151.0773383992755;6155.969220153871;6213.1922850029205;6244.562880598314;6250.218722659668;439.84385543131725;440.62106588334007;441.05393930019926;442.9335599660012;451.24867096284976;4102.712810103324;4386.1008493258805;4392.033752574429;4409.933850992237;4421.4915284742665;10760.515776790064;11146.721331966766;11500.367479788692;11581.88418115808;11602.94198529002;10797.514111864984;10921.672349829518;11140.888591113986;11242;11246.044086252596;8479.618417171243;8657.177568131017;8664.826703466022;8671.262942649819;8686.131386861389;6023.3374328824675;6146.416090471398;6256.374362563707;6349.746010159542;6393.584417012879;10291.53688084053;10711.8928810714;10840.512176952214;10848.620298289521;10881.129509639051;10440.791184176122;10873.238873278795;10922.50848711794;11101.333919964827;11117.777644447227;7706.306432421109;8489.40574159803;8708.303335733253;8858.379913406;9014.909850901407;8960.910390896008;9028.09719028092;9053.18521333057;9062.546872656472;9094.727158185266;7824.295813376596;7885.921140788748;8076;8077.353811695168;8231.711890083818;7796.142424333206;7935.563544005136;8002.399820013406;8054.114047454893;8062.435629505878;7209.0628218331285;7279.090113735783;7284.307990741083;7288.927110728825;7391.189158656163;5086.21163719624;5158.742062896915;5189.221616757365;5215.478452154754;5219.791208351623;5182.533571978389;5431.375391829832;5454.263674404064;5599.1041433370465;5623.297087864017 19:22:58 INFO - PROCESS | 14726 | |4;prototype.html;317.72516772991355;321.7409984962106;322.7982510930668;331.3406321420373;331.3819726210615;5258.815941442051;5299.3307108260915;5325.600579956505;5335.546478549319;5349.491798279162;5247.212918062292;5271.578273738101;5273.683578985254;5277.868053298669;5283.445238249977;3996.5601745761046;4146.792660366985;4169.270377683908;4178.415021896944;4178.623923846853;4125.896852578695;4145.689073319498;4155.168966206756;4166.916661666764;4181.163767246548;4044.7370920890194;4073.775942323171;4099.897502562445;4104.015036391274;4138.8344466221315;3933.4689816874643;3975.3440682287387;4130.752154870703;4146.771927543984;4152.1280531088505;3659.87190448333;3666.4683620874825;3676.3750162472443;3688.4651725499652;3693.261347730465;5069.746512674388;5120.564751996085;5145.30538377318;5169.844904652867;5173.896522069537;4444.20004399208;4563.589276965055;4717.315989181549;4723.291506274052;4737.649769815586;5528.959072510143;5532.474414930575;5535.197396377503;5553.222548843165;5562.360328562227;3981.422693709396;3993.0416699992084;4003.419504171908;4006.198760247962;4007.6393124618926;5616.641010775484;5708.601392658825;5773.769049238025;5783.855403614902;5788.205656246577;4010.1578668479365;4070.5522392536795;4075.1645912587846;4095.1809638072505;4101.507819061731;4116.938245926313;4122.381642753611;4132.938005929914;4141;4150.27370210218;4382.9342559861625;4623.3758442609815;4680.9297860532115;4688.249880019249;4704.223803072455;5562.777488900399;5572.4706152915405;5588.177970125142;5596.776128954796;5606.803761868315;1395.818543589327;1413.7455258053649;1414.278717853902;1414.2928535732135;1415.9858401415854;859.9570021498901;898.9123160975294;905.6830109461636;908.0930046901454;912.6303846942;4756.167670657621;4797.904041919142;4854.611631069506;4874.8781280467565;4904.852854414374;5081.8729531762;5098.439171691111;5100.132977393852;5107.7446127693465;5180.300659411007;4630.83792067276;4754.690945088558;4817.373741413594;4833.534897202452;4856.417229932431;2923.6637786654383;2987.850607469618;3025.8335791531676;3039.7688935980964;3055.893043743503;5856.912146317809;5868.530517558585;5880.14737863016;5896.587238893322;5903.881922361528;5596.776128954878;5790.957627626984;5858.209141765807;5868.94131058684;5937.821865344046;5803.781205946799;5865.853353666193;5890.941090589211;5931.466168044896;5938.832326200905;5617.241672374177;5639;5715.171300161536;5754.798582049608;5764.481196692318;5698.373178950395;5701.144828275792;5723.8569035774435;5724.454397312619;5746.655200687972;5904.966630839672;5912.231409916683;5927.229460170151;5931.970340148272;5932.317783454958;3904.082540603013;4028.71798974069;4035.8183881724804;4056.959430405658;4173.833046678099;5708.372079071216;5709.115087161496;5753;5755.53955683536;5755.71221438918;5467.6719396836315;5524.696141712245;5589.972050139723;5592.049351610317;5600.551955843604;5297.867553311198;5480.506754392124;5522.806701765419;5523.226748255328;5581.441855814549;5454.3454785426;5471.945280547144;5479.835604931858;5499.945000549943;5499.9825032369135;5425.616467800685;5571.832845014656;5589.748461319169;5592.384837667934;5617.831465056055;5448.746788238806;5490.725463726878;5490.945090549043;5491.203775452457;5493.670379777226 19:22:58 INFO - PROCESS | 14726 | |5;yui.html;755.5768769489083;780.2041917244411;784.8704963680993;804.9235322644348;828.7182357998281;15868.285927133278;16727.163641817908;17042.573935651584;17110.31558737652;17155.742663860037;15135;15294.388224471008;15298.617534561614;15301.92349038256;15320.923395383008;653.3694984340111;762.9198934111921;781.9843603127935;784.5763287824568;792.3463142907096;778.7352300217925;783.5298820707587;786.1273985875673;786.9645865936018;787.5196130360475;688.6212583079312;826.7189155687065;827.6896163938524;828.4408024583412;828.6726742936567;803.6825453945688;806.1293802693107;806.701520437436;812.4434762187861;815.1848151848152;606.7694276175025;607.1621162795315;607.2530787131852;607.2985701514757;608.5405518833253;15328.15695136767;15435.3825846966;15444.613884652861;15455.690886182327;15479.613009674735;14461.27693615315;14477.348519316656;14823.925880370636;14825.110493370432;14958.40166393343;12621.432035558422;12641.557545485864;12880.420381082873;12889.419976101004;13080.21518708871;4617.12274667812;4631.884202894921;4664.95335046652;4771.522847715235;4790.856274311742;75039;76816.61591692005;77744.61127694382;77894.99999999943;77961;11594.708041009271;11699.88300117005;11901.10741694359;12046.397680115959;12230.449629766681;20943.162273509195;21366.78633213679;21404.571908561742;21440.892795536234;21460.141594336365;8531.06158322584;8635.438696484709;8733.170348816851;8818.030016698158;9069.229115525122;4769.642276829251;4808.35087263222;4835.540623640749;4890.682105663121;4912.852614421573;3578.177019285527;3733.010752150682;3753.3619284721663;3763.736538442283;3765.9246815063543;626.6553395632384;627.4071002902305;640.324457697134;642.5181114164377;648.1509222917992;687.5187368841831;764.2815753191982;789.4947233770391;790.0637744273055;790.4940837863771;9602.519874006412;10510.264281500222;10511.894881051245;10682.73293167677;10883.33358327215;688.1054628982303;691.7855464805926;736.2232844349263;736.6427282767853;737.5795796396003;4860.781264843091;5031;5090.8404605100195;5108.412532558729;5139.511746384088;121957;123147;123287;124665;126335;82627;84367.5781621088;84679;97306.99999999859;103747.48126259321;84877.57561212154;87975.56012220026;88217.55891220631;88845;88916.55541722379;10349.482525873525;10688.732781680521;10695.518701658288;10883.564657413615;11025.61410350634;46035.76982115068;46105.30842037305;47214.29178562393;49308.75345623249;52382;70066.64966675134;71359;71364;72148.63925680338;73676.21104628182;13407.396667149807;13660.590182294547;13719.245441500812;13940.30298485092;14182.14907105577;15789.921050394674;15952.122633255283;15961.68076638484;16017.839821602101;17048.403305884236;13939.16365018102;14234.857651423767;14904.25478726081;15359.232038397811;15476.690466190837;14295.92852035733;14388.568342949728;14731.558053258419;14832.7775083376;15558.144302063496;14533.27333633293;14696.55910322692;14768.77846832277;15198.620034498783;15605;11566.363849988331;11600.5359785611;11766.941165294118;11887;11991.340476273539;11386.259893106922;11582.247153934968;11747.530098795953;11853.466594003117;11904.166708330335 19:22:58 INFO - PROCESS | 14726 | __end_tp_report 19:22:58 INFO - PROCESS | 14726 | __start_cc_report 19:22:58 INFO - PROCESS | 14726 | _x_x_mozilla_cycle_collect,968 19:22:58 INFO - PROCESS | 14726 | __end_cc_report 19:22:58 INFO - PROCESS | 14726 | __startTimestamp1466302978569__endTimestamp 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | ------- Summary: start ------- 19:22:58 INFO - PROCESS | 14726 | Number of tests: 6 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#0] dojo.html Cycles:165 Average:5400.69 Median:5598.50 stddev:624.81 (11.2%) stddev-sans-first:599.93 19:22:58 INFO - PROCESS | 14726 | Values: 3093.1 3101.9 3129.7 3148.6 3159.8 5310.9 5327.4 5403.9 5419.7 5429.6 5313.9 5330.4 5432.1 5481.7 5533.3 4824.6 4840.5 4859.9 4870.1 5008.8 4955.5 4964.9 5006.3 5033.2 5033.3 4795.9 4823.5 4838.3 4887.2 4974.3 4822.3 4829.3 4830.3 4926.6 4952.2 4889.8 4896.0 4897.3 4902.7 4913.8 5206.2 5359.0 5389.6 5399.9 5425.5 5850.3 5888.0 5962.3 5962.6 5964.4 5917.6 5937.1 5977.9 5980.2 5987.7 5312.4 5400.5 5413.6 5428.3 5499.5 5933.7 5991.6 5996.7 5998.4 6002.1 5458.9 5778.0 5779.2 5789.9 5796.6 5700.5 5765.0 5769.2 5828.5 5836.3 5770.2 5781.1 5800.9 5801.7 5806.2 5647.2 5752.8 5784.4 5788.9 5790.9 4450.2 4485.8 4494.4 4530.3 4533.9 3974.1 3990.9 3991.1 3998.1 4032.4 5353.0 5412.0 5425.2 5538.8 5539.4 5780.7 5804.3 5826.0 5839.1 5852.9 5491.5 5497.9 5500.4 5509.5 5511.5 4857.7 5028.0 5031.8 5055.0 5080.9 6001.8 6090.1 6094.6 6106.7 6110.1 5904.4 5912.5 5913.4 5917.2 5917.6 5810.2 5903.7 5962.0 6043.4 6061.4 5720.5 5761.8 5762.0 5771.2 5813.6 5849.5 5863.5 5872.3 5885.8 5887.6 5486.1 5619.2 5655.8 5686.2 5703.8 5693.2 5707.6 5712.5 5717.4 5719.9 5588.7 5596.9 5597.8 5598.5 5599.8 5449.4 5650.1 5718.5 5724.5 5809.0 5588.8 5616.4 5623.7 5624.7 5667.6 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#1] ext.html Cycles:180 Average:59339.54 Median:227945.19 stddev:116435.48 (51.1%) stddev-sans-first:116678.56 19:22:58 INFO - PROCESS | 14726 | Values: 589.4 601.6 613.1 626.3 631.9 30826.8 42008.6 43065.0 43140.4 43377.9 44836.8 45105.5 45287.3 45389.0 45422.8 9023.6 9149.0 9169.2 9175.5 9181.9 8936.9 9049.9 9052.1 9055.5 9058.6 9088.7 9103.7 9109.5 9119.6 9127.8 9055.6 9076.4 9084.5 9104.3 9110.4 8973.1 9036.1 9042.2 9054.8 9055.5 42654.8 43071.4 43135.6 43192.4 43208.6 3609.5 3860.0 4088.4 4148.0 4395.5 32597.0 33128.7 33245.3 33257.3 34768.0 3836.7 3877.6 3919.7 3951.1 4003.9 318350.0 318715.0 319740.0 320954.0 321407.0 52325.0 57521.1 58627.4 59127.7 59308.0 62286.7 62302.0 62565.7 62915.0 63287.0 16138.0 16302.3 16305.7 16320.3 16354.8 11053.8 12029.8 12266.7 12334.3 12607.5 18169.5 18432.9 18579.3 18587.0 18639.0 5959.6 6002.3 6030.4 6141.3 6168.8 916.8 1042.7 1046.7 1077.2 1135.4 32119.5 32450.9 32522.3 32702.7 32880.8 1029.4 1128.0 1137.3 1147.6 1194.7 17043.6 18092.2 18124.5 18963.6 19072.9 550873.0 550945.0 551587.0 553814.0 555380.0 58632.0 58674.0 58740.0 58770.1 59007.0 1252.5 1333.2 1374.5 1378.3 1390.5 31742.0 32931.7 33374.7 33550.8 34076.3 50891.0 51219.0 51361.0 51391.7 51516.5 410341.0 413148.0 413159.0 413335.0 414495.0 24805.0 27278.5 28099.6 28383.3 29795.7 47130.3 47849.5 48516.0 48930.0 49092.0 40492.4 40534.0 40995.4 41524.8 42216.0 40839.6 41099.0 41354.4 41395.4 41693.2 40606.0 41206.6 41455.2 41488.0 41563.0 35733.5 36290.6 36502.6 36875.3 37209.6 28149.4 28232.2 28252.5 28284.6 28410.4 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#2] jquery.html Cycles:180 Average:28010.25 Median:2864.52 stddev:75450.26 (2634.0%) stddev-sans-first:75633.41 19:22:58 INFO - PROCESS | 14726 | Values: 386.9 389.3 399.2 400.0 418.4 13988.9 16015.6 17627.5 19218.3 19302.5 13040.9 15254.7 15540.9 17720.4 17729.9 5612.4 5650.4 5707.9 5778.6 5797.3 3955.0 5725.9 5752.2 5783.9 6088.1 6504.7 6518.9 6607.7 6616.6 6629.2 6516.5 6579.9 6594.9 6645.7 6645.9 5682.6 5759.0 5793.8 5799.7 5806.0 22729.2 22890.4 23118.3 23499.1 23579.9 2519.9 2586.5 2593.7 2816.4 2912.6 14308.3 14345.0 14638.7 14891.5 15133.7 1998.5 2022.6 2038.8 2043.2 2049.9 80090.6 81816.0 81970.6 82234.0 82988.0 9947.7 9978.6 10340.5 10410.3 10519.4 14263.1 14385.1 14395.8 14417.1 14417.8 7025.2 7674.0 7736.4 7751.8 7827.1 7754.2 7794.9 8080.4 8263.0 8328.9 6656.9 6670.3 6681.1 6683.2 6836.9 1915.5 1928.5 1936.8 1947.8 2013.7 884.9 978.2 995.9 1021.7 1080.1 19504.7 19826.5 19846.9 19892.8 19990.8 1008.7 1025.9 1060.8 1067.2 1077.2 8930.9 11332.8 11456.4 11483.4 11532.4 435960.0 441538.0 459613.0 467556.0 475131.0 88702.6 94201.5 94228.0 94870.0 95282.5 980.6 1005.1 1015.9 1021.9 1039.0 16851.2 17098.8 17128.8 17370.1 17661.3 32391.7 39030.8 39389.6 40717.6 41608.0 56133.0 58072.4 58494.1 58611.7 58895.7 7129.8 7497.7 8015.0 8338.8 8408.5 12366.3 13020.9 13087.5 13100.9 13146.9 10928.5 11303.8 11328.9 11383.8 11437.9 11252.4 11286.7 11296.5 11642.1 11710.1 11458.4 11613.6 11843.8 11868.6 11995.6 7538.6 7719.8 7841.4 7866.9 7878.0 9814.6 11583.5 11636.9 11690.7 11829.3 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#3] mootools.html Cycles:180 Average:6058.45 Median:2436.37 stddev:3506.51 (143.9%) stddev-sans-first:3498.25 19:22:58 INFO - PROCESS | 14726 | Values: 1318.0 1488.5 1526.1 1673.6 1798.5 8498.7 9007.5 9076.6 9351.7 9381.7 9010.9 9196.1 9213.6 9226.9 9232.6 2069.0 2308.6 2383.8 2416.9 2418.9 2500.7 2503.5 2508.1 2509.0 2511.3 2411.8 2472.5 2480.4 2480.4 2481.0 2068.2 2295.1 2352.2 2366.6 2371.2 2365.6 2376.3 2397.1 2397.2 2399.8 9143.7 9223.2 9249.1 9318.9 9389.3 5295.9 5439.4 5448.3 5448.3 5503.7 3345.1 3565.9 3607.9 3612.5 3638.0 1151.9 1164.4 1180.7 1193.4 1199.8 13051.1 13080.1 13087.1 13099.3 13104.1 4755.7 4859.5 4938.9 4958.3 4965.1 10837.8 10891.8 10894.6 10901.9 10914.4 5436.0 5445.2 5446.1 5447.9 5449.4 4381.8 4850.9 4942.2 4962.0 5043.5 4093.4 4107.9 4150.5 4176.7 4201.7 1245.1 1286.5 1291.9 1296.1 1306.9 892.7 980.5 993.7 995.8 1014.6 6151.1 6156.0 6213.2 6244.6 6250.2 439.8 440.6 441.1 442.9 451.2 4102.7 4386.1 4392.0 4409.9 4421.5 10760.5 11146.7 11500.4 11581.9 11602.9 10797.5 10921.7 11140.9 11242.0 11246.0 8479.6 8657.2 8664.8 8671.3 8686.1 6023.3 6146.4 6256.4 6349.7 6393.6 10291.5 10711.9 10840.5 10848.6 10881.1 10440.8 10873.2 10922.5 11101.3 11117.8 7706.3 8489.4 8708.3 8858.4 9014.9 8960.9 9028.1 9053.2 9062.5 9094.7 7824.3 7885.9 8076.0 8077.4 8231.7 7796.1 7935.6 8002.4 8054.1 8062.4 7209.1 7279.1 7284.3 7288.9 7391.2 5086.2 5158.7 5189.2 5215.5 5219.8 5182.5 5431.4 5454.3 5599.1 5623.3 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#4] prototype.html Cycles:180 Average:4632.92 Median:5253.01 stddev:1367.22 (26.0%) stddev-sans-first:1332.14 19:22:58 INFO - PROCESS | 14726 | Values: 317.7 321.7 322.8 331.3 331.4 5258.8 5299.3 5325.6 5335.5 5349.5 5247.2 5271.6 5273.7 5277.9 5283.4 3996.6 4146.8 4169.3 4178.4 4178.6 4125.9 4145.7 4155.2 4166.9 4181.2 4044.7 4073.8 4099.9 4104.0 4138.8 3933.5 3975.3 4130.8 4146.8 4152.1 3659.9 3666.5 3676.4 3688.5 3693.3 5069.7 5120.6 5145.3 5169.8 5173.9 4444.2 4563.6 4717.3 4723.3 4737.6 5529.0 5532.5 5535.2 5553.2 5562.4 3981.4 3993.0 4003.4 4006.2 4007.6 5616.6 5708.6 5773.8 5783.9 5788.2 4010.2 4070.6 4075.2 4095.2 4101.5 4116.9 4122.4 4132.9 4141.0 4150.3 4382.9 4623.4 4680.9 4688.2 4704.2 5562.8 5572.5 5588.2 5596.8 5606.8 1395.8 1413.7 1414.3 1414.3 1416.0 860.0 898.9 905.7 908.1 912.6 4756.2 4797.9 4854.6 4874.9 4904.9 5081.9 5098.4 5100.1 5107.7 5180.3 4630.8 4754.7 4817.4 4833.5 4856.4 2923.7 2987.9 3025.8 3039.8 3055.9 5856.9 5868.5 5880.1 5896.6 5903.9 5596.8 5791.0 5858.2 5868.9 5937.8 5803.8 5865.9 5890.9 5931.5 5938.8 5617.2 5639.0 5715.2 5754.8 5764.5 5698.4 5701.1 5723.9 5724.5 5746.7 5905.0 5912.2 5927.2 5932.0 5932.3 3904.1 4028.7 4035.8 4057.0 4173.8 5708.4 5709.1 5753.0 5755.5 5755.7 5467.7 5524.7 5590.0 5592.0 5600.6 5297.9 5480.5 5522.8 5523.2 5581.4 5454.3 5471.9 5479.8 5499.9 5500.0 5425.6 5571.8 5589.7 5592.4 5617.8 5448.7 5490.7 5490.9 5491.2 5493.7 19:22:58 INFO - PROCESS | 14726 | 19:22:58 INFO - PROCESS | 14726 | [#5] yui.html Cycles:180 Average:21117.62 Median:46070.54 stddev:29989.05 (65.1%) stddev-sans-first:30034.20 19:22:58 INFO - PROCESS | 14726 | Values: 755.6 780.2 784.9 804.9 828.7 15868.3 16727.2 17042.6 17110.3 17155.7 15135.0 15294.4 15298.6 15301.9 15320.9 653.4 762.9 782.0 784.6 792.3 778.7 783.5 786.1 787.0 787.5 688.6 826.7 827.7 828.4 828.7 803.7 806.1 806.7 812.4 815.2 606.8 607.2 607.3 607.3 608.5 15328.2 15435.4 15444.6 15455.7 15479.6 14461.3 14477.3 14823.9 14825.1 14958.4 12621.4 12641.6 12880.4 12889.4 13080.2 4617.1 4631.9 4665.0 4771.5 4790.9 75039.0 76816.6 77744.6 77895.0 77961.0 11594.7 11699.9 11901.1 12046.4 12230.4 20943.2 21366.8 21404.6 21440.9 21460.1 8531.1 8635.4 8733.2 8818.0 9069.2 4769.6 4808.4 4835.5 4890.7 4912.9 3578.2 3733.0 3753.4 3763.7 3765.9 626.7 627.4 640.3 642.5 648.2 687.5 764.3 789.5 790.1 790.5 9602.5 10510.3 10511.9 10682.7 10883.3 688.1 691.8 736.2 736.6 737.6 4860.8 5031.0 5090.8 5108.4 5139.5 121957.0 123147.0 123287.0 124665.0 126335.0 82627.0 84367.6 84679.0 97307.0 103747.5 84877.6 87975.6 88217.6 88845.0 88916.6 10349.5 10688.7 10695.5 10883.6 11025.6 46035.8 46105.3 47214.3 49308.8 52382.0 70066.6 71359.0 71364.0 72148.6 73676.2 13407.4 13660.6 13719.2 13940.3 14182.1 15789.9 15952.1 15961.7 16017.8 17048.4 13939.2 14234.9 14904.3 15359.2 15476.7 14295.9 14388.6 14731.6 14832.8 15558.1 14533.3 14696.6 14768.8 15198.6 15605.0 11566.4 11600.5 11766.9 11887.0 11991.3 11386.3 11582.2 11747.5 11853.5 11904.2 19:22:58 INFO - PROCESS | 14726 | -------- Summary: end -------- 19:22:58 INFO - PROCESS | 14726 | 19:22:59 INFO - TEST-INFO | 14726: exit 0 19:22:59 INFO - TEST-OK | dromaeo_css | took 1113536ms 19:22:59 INFO - TEST-START | kraken 19:22:59 INFO - operating with platform_type : linux_ 19:22:59 INFO - Initialising browser for kraken test... 19:22:59 INFO - TEST-INFO | started process 14910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPX80P/profile http://localhost:48630/getInfo.html) 19:23:03 INFO - PROCESS | 14910 | __metrics Screen width/height:1600/1200 19:23:03 INFO - PROCESS | 14910 | colorDepth:24 19:23:03 INFO - PROCESS | 14910 | Browser inner width/height: 1024/697 19:23:03 INFO - PROCESS | 14910 | __metrics 19:23:04 INFO - PROCESS | 14910 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:05 INFO - TEST-INFO | 14910: exit 0 19:23:05 INFO - Browser initialized. 19:23:05 INFO - Running cycle 1/1 for kraken test... 19:23:05 INFO - TEST-INFO | started process 14990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPX80P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:17 INFO - PROCESS | 14990 | RSS: Main: 173625344 19:23:17 INFO - PROCESS | 14990 | 19:23:19 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:20 INFO - PROCESS | 14990 | RSS: Main: 232853504 19:23:20 INFO - PROCESS | 14990 | 19:23:23 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-dft) 19:23:23 INFO - PROCESS | 14990 | RSS: Main: 220905472 19:23:23 INFO - PROCESS | 14990 | 19:23:27 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-fft) 19:23:27 INFO - PROCESS | 14990 | RSS: Main: 286695424 19:23:27 INFO - PROCESS | 14990 | 19:23:29 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-oscillator) 19:23:30 INFO - PROCESS | 14990 | RSS: Main: 197963776 19:23:30 INFO - PROCESS | 14990 | 19:23:32 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:33 INFO - PROCESS | 14990 | RSS: Main: 202240000 19:23:33 INFO - PROCESS | 14990 | 19:23:36 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:36 INFO - PROCESS | 14990 | RSS: Main: 238538752 19:23:36 INFO - PROCESS | 14990 | 19:23:40 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:40 INFO - PROCESS | 14990 | RSS: Main: 238456832 19:23:40 INFO - PROCESS | 14990 | 19:23:43 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48630/tests/kraken/driver.html?testName=json-parse-financial) 19:23:44 INFO - PROCESS | 14990 | RSS: Main: 238714880 19:23:44 INFO - PROCESS | 14990 | 19:23:45 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:46 INFO - PROCESS | 14990 | RSS: Main: 228286464 19:23:46 INFO - PROCESS | 14990 | 19:23:48 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:48 INFO - PROCESS | 14990 | RSS: Main: 230973440 19:23:48 INFO - PROCESS | 14990 | 19:23:50 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:51 INFO - PROCESS | 14990 | RSS: Main: 238563328 19:23:51 INFO - PROCESS | 14990 | 19:23:53 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:54 INFO - PROCESS | 14990 | RSS: Main: 239951872 19:23:54 INFO - PROCESS | 14990 | 19:23:57 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:57 INFO - PROCESS | 14990 | RSS: Main: 238596096 19:23:57 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48630/tests/kraken/driver.html?testName=ai-astar) 19:23:59 INFO - PROCESS | 14990 | RSS: Main: 282300416 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | __start_tp_report 19:23:59 INFO - PROCESS | 14990 | _x_x_mozilla_page_load 19:23:59 INFO - PROCESS | 14990 | _x_x_mozilla_page_load_details 19:23:59 INFO - PROCESS | 14990 | |i|pagename|runs| 19:23:59 INFO - PROCESS | 14990 | |0;ai-astar;114;106;110;110;112;109;109;111;109;109 19:23:59 INFO - PROCESS | 14990 | |1;audio-beat-detection;151;123;127;174;128;128;163;124;180;128 19:23:59 INFO - PROCESS | 14990 | |2;audio-dft;161;162;162;162;161;162;159;162;161;161 19:23:59 INFO - PROCESS | 14990 | |3;audio-fft;75;75;74;128;76;75;74;74;102;75 19:23:59 INFO - PROCESS | 14990 | |4;audio-oscillator;84;86;107;85;85;86;111;83;84;132 19:23:59 INFO - PROCESS | 14990 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;118;117 19:23:59 INFO - PROCESS | 14990 | |6;imaging-darkroom;147;148;148;147;147;145;146;146;145;145 19:23:59 INFO - PROCESS | 14990 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 19:23:59 INFO - PROCESS | 14990 | |8;json-parse-financial;55;53;57;54;53;61;54;57;54;57 19:23:59 INFO - PROCESS | 14990 | |9;json-stringify-tinderbox;61;62;61;61;61;62;61;61;62;61 19:23:59 INFO - PROCESS | 14990 | |10;stanford-crypto-aes;89;83;79;79;85;80;80;83;112;79 19:23:59 INFO - PROCESS | 14990 | |11;stanford-crypto-ccm;131;124;129;121;127;120;120;133;129;124 19:23:59 INFO - PROCESS | 14990 | |12;stanford-crypto-pbkdf2;162;165;167;171;169;169;170;168;164;160 19:23:59 INFO - PROCESS | 14990 | |13;stanford-crypto-sha256-iterative;64;65;68;64;64;63;63;62;63;65 19:23:59 INFO - PROCESS | 14990 | __end_tp_report 19:23:59 INFO - PROCESS | 14990 | __start_cc_report 19:23:59 INFO - PROCESS | 14990 | _x_x_mozilla_cycle_collect,1635 19:23:59 INFO - PROCESS | 14990 | __end_cc_report 19:23:59 INFO - PROCESS | 14990 | __startTimestamp1466303039847__endTimestamp 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | ------- Summary: start ------- 19:23:59 INFO - PROCESS | 14990 | Number of tests: 14 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.13 (1.9%) stddev-sans-first:1.67 19:23:59 INFO - PROCESS | 14990 | Values: 114.0 106.0 110.0 110.0 112.0 109.0 109.0 111.0 109.0 109.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:139.50 stddev:22.32 (16.0%) stddev-sans-first:23.47 19:23:59 INFO - PROCESS | 14990 | Values: 151.0 123.0 127.0 174.0 128.0 128.0 163.0 124.0 180.0 128.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 19:23:59 INFO - PROCESS | 14990 | Values: 161.0 162.0 162.0 162.0 161.0 162.0 159.0 162.0 161.0 161.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:18.05 (24.1%) stddev-sans-first:18.93 19:23:59 INFO - PROCESS | 14990 | Values: 75.0 75.0 74.0 128.0 76.0 75.0 74.0 74.0 102.0 75.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.50 stddev:16.71 (19.8%) stddev-sans-first:17.30 19:23:59 INFO - PROCESS | 14990 | Values: 84.0 86.0 107.0 85.0 85.0 86.0 111.0 83.0 84.0 132.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:23:59 INFO - PROCESS | 14990 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:1.17 (0.8%) stddev-sans-first:1.22 19:23:59 INFO - PROCESS | 14990 | Values: 147.0 148.0 148.0 147.0 147.0 145.0 146.0 146.0 145.0 145.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:23:59 INFO - PROCESS | 14990 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:2.51 (4.5%) stddev-sans-first:2.65 19:23:59 INFO - PROCESS | 14990 | Values: 55.0 53.0 57.0 54.0 53.0 61.0 54.0 57.0 54.0 57.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 19:23:59 INFO - PROCESS | 14990 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:81.50 stddev:10.06 (12.3%) stddev-sans-first:10.56 19:23:59 INFO - PROCESS | 14990 | Values: 89.0 83.0 79.0 79.0 85.0 80.0 80.0 83.0 112.0 79.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:128.00 stddev:4.69 (3.7%) stddev-sans-first:4.58 19:23:59 INFO - PROCESS | 14990 | Values: 131.0 124.0 129.0 121.0 127.0 120.0 120.0 133.0 129.0 124.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:168.50 stddev:3.63 (2.2%) stddev-sans-first:3.46 19:23:59 INFO - PROCESS | 14990 | Values: 162.0 165.0 167.0 171.0 169.0 169.0 170.0 168.0 164.0 160.0 19:23:59 INFO - PROCESS | 14990 | 19:23:59 INFO - PROCESS | 14990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.66 (2.6%) stddev-sans-first:1.76 19:23:59 INFO - PROCESS | 14990 | Values: 64.0 65.0 68.0 64.0 64.0 63.0 63.0 62.0 63.0 65.0 19:23:59 INFO - PROCESS | 14990 | -------- Summary: end -------- 19:23:59 INFO - PROCESS | 14990 | 19:24:00 INFO - TEST-INFO | 14990: exit 0 19:24:00 INFO - TEST-OK | kraken | took 61499ms 19:24:00 INFO - SUITE-END | took 1175s 19:24:01 INFO - Completed test suite (00:19:35) 19:24:01 INFO - javascript benchmark 19:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.1184612385473, 3101.8604162812658, 3129.6870312968704, 3148.637906640737, 3159.8420078996046, 5310.893782124355, 5327.387350454699, 5403.891922161564, 5419.701916394597, 5429.56563474922, 5313.946860531393, 5330.387005494369, 5432.103702889019, 5481.725913704318, 5533.335999680034, 4824.565789078983, 4840.491748366415, 4859.927101093486, 4870.147724148278, 5008.84973450797, 4955.479674634165, 4964.900701985958, 5006.349174607296, 5033.194688849785, 5033.270175824503, 4795.904081918359, 4823.5176482351835, 4838.250071238946, 4887.169181239198, 4974.303597496335, 4822.300766388854, 4829.275608658694, 4830.2513110467935, 4926.630502712311, 4952.182889823175, 4889.75551222441, 4896.020795840846, 4897.2654101885, 4902.681325713817, 4913.754312284372, 5206.24509446132, 5358.973205133989, 5389.622726409153, 5399.892002159974, 5425.511703946624, 5850.297964244275, 5888.0, 5962.314333851619, 5962.582619216657, 5964.403559644044, 5917.556183286228, 5937.109433584954, 5977.850553736148, 5980.222571065734, 5987.670678112702, 5312.389075256357, 5400.513953744182, 5413.621046526745, 5428.267183930119, 5499.532539734168, 5933.6736479493175, 5991.580589358703, 5996.730147143389, 5998.430149135826, 6002.069679199731, 5458.945410545924, 5778.046622307273, 5779.248697669276, 5789.88420231593, 5796.565257605696, 5700.486956173964, 5765.04876695349, 5769.1634712967225, 5828.5337173026055, 5836.299644042742, 5770.2498675171955, 5781.103928891029, 5800.941990580124, 5801.680907550125, 5806.2451881255165, 5647.237622920853, 5752.827415177551, 5784.392638772868, 5788.942110578841, 5790.913136302959, 4450.2434586120435, 4485.842995495142, 4494.37078808967, 4530.343100250445, 4533.909321813611, 3974.066094467798, 3990.86031988879, 3991.1219531702977, 3998.140399814054, 4032.4152997815154, 5352.973235133877, 5412.0, 5425.213344065089, 5538.778448862081, 5539.418361072029, 5780.682062486603, 5804.332501762267, 5826.038703613941, 5839.065749480063, 5852.882942341214, 5491.450854914477, 5497.917531237034, 5500.3949565547755, 5509.531689806331, 5511.53151982086, 4857.684250523705, 5027.974860125676, 5031.84904452867, 5055.039542486989, 5080.949190508121, 6001.7599296027665, 6090.056041313604, 6094.561897584374, 6106.72519736613, 6110.133516259496, 5904.3800400959, 5912.526997840248, 5913.379095194942, 5917.201177840936, 5917.644941303535, 5810.1575271586225, 5903.704814759159, 5962.046072628359, 6043.365446628217, 6061.36355682647, 5720.456556627114, 5761.769529218952, 5762.049261871744, 5771.163181338767, 5813.563982701399, 5849.502792262535, 5863.501602363847, 5872.324682661378, 5885.823425297248, 5887.646741195542, 5486.067368547437, 5619.185218143428, 5655.830325090254, 5686.232358631697, 5703.828885133453, 5693.202951586864, 5707.600467967369, 5712.457316554921, 5717.42825717425, 5719.942800572107, 5588.6646801192055, 5596.86007849807, 5597.832065038056, 5598.496135347838, 5599.804006859903, 5449.427810079885, 5650.067738823048, 5718.542516598579, 5724.484796368347, 5809.041508151107, 5588.804391846266, 5616.410276920865, 5623.662580245198, 5624.718764061862, 5667.574931880208], "value": 5358.001243747575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.3899813692829, 601.6029420582415, 613.1171113596423, 626.30792973764, 631.8988961766119, 30826.845865770694, 42008.57991420085, 43065.0, 43140.35289470653, 43377.915552111175, 44836.77581612096, 45105.54894451055, 45287.32069018967, 45389.0, 45422.77288613561, 9023.593938272777, 9148.954255228715, 9169.220616247627, 9175.54122293886, 9181.862272065924, 8936.910630893673, 9049.864252036225, 9052.094790520929, 9055.547222638874, 9058.637654493812, 9088.727338179866, 9103.681371152012, 9109.45343279402, 9119.635214591408, 9127.771805704877, 9055.592498337557, 9076.410033347844, 9084.545772711337, 9104.271658267357, 9110.407823491518, 8973.10268973104, 9036.096390360977, 9042.18620324174, 9054.773630659287, 9055.547222638841, 42654.78672606617, 43071.35392969108, 43135.56864431378, 43192.352114718306, 43208.56791432077, 3609.5127157833617, 3859.996400935777, 4088.407180958774, 4148.02521407469, 4395.450568678915, 32597.0, 33128.66871331304, 33245.33509329824, 33257.334853303044, 34768.0, 3836.6738827199442, 3877.6316249956208, 3919.7256192066566, 3951.111000025, 4003.8798836034966, 318349.9999999977, 318715.0, 319740.0, 320954.0, 321407.0, 52325.0, 57521.137182942286, 58627.41372586305, 59127.70436147792, 59308.0, 62286.68856655688, 62302.0, 62565.68717156385, 62915.0, 63287.0, 16138.0, 16302.347906083623, 16305.673886522203, 16320.286369931224, 16354.836451635569, 11053.778924421467, 12029.759404811855, 12266.693332666755, 12334.321612311229, 12607.495700172074, 18169.45491635253, 18432.907835460737, 18579.349722759638, 18587.0, 18639.0, 5959.64242145464, 6002.279726432856, 6030.366811484819, 6141.324454310023, 6168.753249870045, 916.7708072981754, 1042.702829693549, 1046.7173863056933, 1077.235163034239, 1135.381217236608, 32119.51820722691, 32450.943632045994, 32522.349553008808, 32702.672973270437, 32880.83559582235, 1029.4286670897575, 1128.0468004536153, 1137.3403426012892, 1147.552454542729, 1194.66443103732, 17043.573910652332, 18092.185851636707, 18124.546886327684, 18963.62072758537, 19072.90463547701, 550873.0, 550945.0, 551587.0, 553814.0, 555380.0, 58632.0, 58674.0, 58740.0, 58770.11844822331, 59007.0, 1252.5240408644838, 1333.153447560806, 1374.4502199120432, 1378.269517155889, 1390.5341710526884, 31742.0, 32931.67068329382, 33374.66625333716, 33550.83224583862, 34076.31847362989, 50891.0, 51219.0, 51361.0, 51391.74304128456, 51516.48483515117, 410341.0, 413148.0, 413159.0, 413335.0, 414495.0, 24805.0, 27278.454430910875, 28099.578506322014, 28383.29041773972, 29795.702042979294, 47130.29304560503, 47849.521504784505, 48516.0, 48930.0, 49092.0, 40492.39261411022, 40534.0, 40995.38506922458, 41524.79237603793, 42216.0, 40839.56170818373, 41099.0, 41354.37968430416, 41395.379069313385, 41693.16613667649, 40606.0, 41206.587934121475, 41455.1708965825, 41488.0, 41563.0, 35733.46399803953, 36290.63709362873, 36502.62590963626, 36875.26249475049, 37209.62790372062, 28149.394014345784, 28232.15303540897, 28252.514555335427, 28284.575731364457, 28410.431791363644], "value": 20101.762901357797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.85106234099874, 389.27011852776064, 399.2015968063872, 399.9960100148627, 418.3682639214787, 13988.930055349734, 16015.599610009756, 17627.471175864728, 19218.327358542454, 19302.517437064063, 13040.869591304085, 15254.694906101871, 15540.922295388535, 17720.379786707468, 17729.91135044326, 5612.438756124386, 5650.378458369576, 5707.885842283152, 5778.6243894146955, 5797.333306669745, 3954.960450395488, 5725.942740572604, 5752.194692742998, 5783.855403614902, 6088.147659327676, 6504.739810407602, 6518.902216466757, 6607.735690572371, 6616.636085015322, 6629.171353580802, 6516.5112616553715, 6579.868402631944, 6594.8681026379445, 6645.734170633169, 6645.93354066458, 5682.573806964494, 5758.971205143989, 5793.797217097382, 5799.710014499258, 5806.042003069489, 22729.204477843363, 22890.427739306484, 23118.306450806504, 23499.060037598476, 23579.88210058956, 2519.86140762258, 2586.456844062749, 2593.714691383946, 2816.4367126574766, 2912.606798082274, 14308.28458577067, 14345.0, 14638.707225855424, 14891.47879824201, 15133.697326053527, 1998.4704053425853, 2022.565148493081, 2038.8266997305248, 2043.162303455591, 2049.897505124738, 80090.5995470019, 81816.0, 81970.59014704949, 82234.0, 82988.0, 9947.651832185838, 9978.550965206583, 10340.482975851328, 10410.323328983592, 10519.368837869752, 14263.07290026145, 14385.136891786526, 14395.78406323906, 14417.13497190172, 14417.78373324401, 7025.156981162293, 7674.0, 7736.381089512825, 7751.7674469766, 7827.099883513469, 7754.18581048993, 7794.883076753853, 8080.39397045224, 8263.049749278909, 8328.875066874001, 6656.8668626627195, 6670.266270710218, 6681.098051763047, 6683.2314283857, 6836.897446538306, 1915.549845786239, 1928.4793105861338, 1936.7772706138692, 1947.7760057593557, 2013.7180794688754, 884.920357167858, 978.1587834462357, 995.8904520502739, 1021.6883850425543, 1080.114306268852, 19504.70742938857, 19826.50433739168, 19846.90076549608, 19892.801071989383, 19990.800091998895, 1008.7377281906757, 1025.9487025648689, 1060.7613287010515, 1067.1889364083352, 1077.197487871525, 8930.86603700945, 11332.830007549728, 11456.3698996556, 11483.36841473727, 11532.423378831192, 435960.0, 441538.0, 459613.0, 467556.0, 475131.0, 88702.55648721845, 94201.5289923546, 94228.0, 94870.0, 95282.52358738301, 980.578351308944, 1005.1355833982769, 1015.9288849780593, 1021.8722659667542, 1038.963636272742, 16851.1574421276, 17098.829011710222, 17128.828711712722, 17370.13149342553, 17661.293548257927, 32391.67608323981, 39030.80484597672, 39389.60610393974, 40717.59282407138, 41607.959801005214, 56133.0, 58072.4192758067, 58494.12258816036, 58611.70694146502, 58895.70552147212, 7129.750458733919, 7497.737579184703, 8015.0, 8338.79153021155, 8408.537530435884, 12366.319852408204, 13020.869791301966, 13087.541936032574, 13100.868991309964, 13146.948244140254, 10928.50821713009, 11303.773924521627, 11328.886711132784, 11383.829242561535, 11437.885621143681, 11252.381119038204, 11286.717832054264, 11296.548138074713, 11642.126840486828, 11710.12174086964, 11458.4270786462, 11613.593524226611, 11843.822342665038, 11868.58459953932, 11995.580154694893, 7538.623068846646, 7719.845603088019, 7841.411894108079, 7866.8819967701675, 7878.0, 9814.607415703293, 11583.536658533565, 11636.88363116358, 11690.70773230676, 11829.34938578352], "value": 9315.140128668896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.9538716144937, 1488.464152904954, 1526.1072272720457, 1673.5607377655215, 1798.5413719501532, 8498.745037648865, 9007.504587247699, 9076.591553380098, 9351.6726914558, 9381.718548443541, 9010.909890901088, 9196.0803919608, 9213.631454741819, 9226.907730922689, 9232.584533695983, 2068.979310206901, 2308.5844547981355, 2383.7735415135576, 2416.915407960722, 2418.8790560471994, 2500.6624105745673, 2503.5493611149986, 2508.147229941819, 2509.046562306321, 2511.2717311979595, 2411.758824117583, 2472.4807790364043, 2480.3923038855505, 2480.4419005723657, 2481.0, 2068.152057656361, 2295.070496448924, 2352.164981431593, 2366.5503554324623, 2371.193794110011, 2365.562370961378, 2376.3346263046374, 2397.06514459361, 2397.2209032064475, 2399.8320117591775, 9143.725688229364, 9223.169914707709, 9249.075092490697, 9318.906810931872, 9389.295802814748, 5295.920561191585, 5439.401665816757, 5448.264484294609, 5448.318960129984, 5503.724813759296, 3345.130266130799, 3565.893023209308, 3607.9098022549383, 3612.5123108380294, 3637.963620363789, 1151.8675352334506, 1164.3828770751516, 1180.740237147826, 1193.3973343461496, 1199.790036743575, 13051.086423950423, 13080.149790263698, 13087.149335293176, 13099.279539625317, 13104.148230365092, 4755.738434386142, 4859.514048595112, 4938.925916111261, 4958.256261560723, 4965.131102057126, 10837.778255457612, 10891.782164356828, 10894.564217431373, 10901.890981090246, 10914.399708016135, 5436.0486914790545, 5445.210444485607, 5446.101393270145, 5447.891042179213, 5449.4005659377435, 4381.759003254851, 4850.854474365775, 4942.159832828428, 4961.975190124026, 5043.5460808527405, 4093.406456063854, 4107.9178416431505, 4150.501939767248, 4176.686748493875, 4201.70588058833, 1245.0786418050577, 1286.5368467351745, 1291.9483220671068, 1296.118639325249, 1306.9477220911058, 892.7321803458937, 980.4901451245313, 993.6720882108887, 995.8058178655093, 1014.6499457687086, 6151.0773383992755, 6155.969220153871, 6213.1922850029205, 6244.562880598314, 6250.218722659668, 439.84385543131725, 440.62106588334007, 441.05393930019926, 442.9335599660012, 451.24867096284976, 4102.712810103324, 4386.1008493258805, 4392.033752574429, 4409.933850992237, 4421.4915284742665, 10760.515776790064, 11146.721331966766, 11500.367479788692, 11581.88418115808, 11602.94198529002, 10797.514111864984, 10921.672349829518, 11140.888591113986, 11242.0, 11246.044086252596, 8479.618417171243, 8657.177568131017, 8664.826703466022, 8671.262942649819, 8686.131386861389, 6023.3374328824675, 6146.416090471398, 6256.374362563707, 6349.746010159542, 6393.584417012879, 10291.53688084053, 10711.8928810714, 10840.512176952214, 10848.620298289521, 10881.129509639051, 10440.791184176122, 10873.238873278795, 10922.50848711794, 11101.333919964827, 11117.777644447227, 7706.306432421109, 8489.40574159803, 8708.303335733253, 8858.379913406, 9014.909850901407, 8960.910390896008, 9028.09719028092, 9053.18521333057, 9062.546872656472, 9094.727158185266, 7824.295813376596, 7885.921140788748, 8076.0, 8077.353811695168, 8231.711890083818, 7796.142424333206, 7935.563544005136, 8002.399820013406, 8054.114047454893, 8062.435629505878, 7209.0628218331285, 7279.090113735783, 7284.307990741083, 7288.927110728825, 7391.189158656163, 5086.21163719624, 5158.742062896915, 5189.221616757365, 5215.478452154754, 5219.791208351623, 5182.533571978389, 5431.375391829832, 5454.263674404064, 5599.1041433370465, 5623.297087864017], "value": 4729.26990165944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.72516772991355, 321.7409984962106, 322.7982510930668, 331.3406321420373, 331.3819726210615, 5258.815941442051, 5299.3307108260915, 5325.600579956505, 5335.546478549319, 5349.491798279162, 5247.212918062292, 5271.578273738101, 5273.683578985254, 5277.868053298669, 5283.445238249977, 3996.5601745761046, 4146.792660366985, 4169.270377683908, 4178.415021896944, 4178.623923846853, 4125.896852578695, 4145.689073319498, 4155.168966206756, 4166.916661666764, 4181.163767246548, 4044.7370920890194, 4073.775942323171, 4099.897502562445, 4104.015036391274, 4138.8344466221315, 3933.4689816874643, 3975.3440682287387, 4130.752154870703, 4146.771927543984, 4152.1280531088505, 3659.87190448333, 3666.4683620874825, 3676.3750162472443, 3688.4651725499652, 3693.261347730465, 5069.746512674388, 5120.564751996085, 5145.30538377318, 5169.844904652867, 5173.896522069537, 4444.20004399208, 4563.589276965055, 4717.315989181549, 4723.291506274052, 4737.649769815586, 5528.959072510143, 5532.474414930575, 5535.197396377503, 5553.222548843165, 5562.360328562227, 3981.422693709396, 3993.0416699992084, 4003.419504171908, 4006.198760247962, 4007.6393124618926, 5616.641010775484, 5708.601392658825, 5773.769049238025, 5783.855403614902, 5788.205656246577, 4010.1578668479365, 4070.5522392536795, 4075.1645912587846, 4095.1809638072505, 4101.507819061731, 4116.938245926313, 4122.381642753611, 4132.938005929914, 4141.0, 4150.27370210218, 4382.9342559861625, 4623.3758442609815, 4680.9297860532115, 4688.249880019249, 4704.223803072455, 5562.777488900399, 5572.4706152915405, 5588.177970125142, 5596.776128954796, 5606.803761868315, 1395.818543589327, 1413.7455258053649, 1414.278717853902, 1414.2928535732135, 1415.9858401415854, 859.9570021498901, 898.9123160975294, 905.6830109461636, 908.0930046901454, 912.6303846942, 4756.167670657621, 4797.904041919142, 4854.611631069506, 4874.8781280467565, 4904.852854414374, 5081.8729531762, 5098.439171691111, 5100.132977393852, 5107.7446127693465, 5180.300659411007, 4630.83792067276, 4754.690945088558, 4817.373741413594, 4833.534897202452, 4856.417229932431, 2923.6637786654383, 2987.850607469618, 3025.8335791531676, 3039.7688935980964, 3055.893043743503, 5856.912146317809, 5868.530517558585, 5880.14737863016, 5896.587238893322, 5903.881922361528, 5596.776128954878, 5790.957627626984, 5858.209141765807, 5868.94131058684, 5937.821865344046, 5803.781205946799, 5865.853353666193, 5890.941090589211, 5931.466168044896, 5938.832326200905, 5617.241672374177, 5639.0, 5715.171300161536, 5754.798582049608, 5764.481196692318, 5698.373178950395, 5701.144828275792, 5723.8569035774435, 5724.454397312619, 5746.655200687972, 5904.966630839672, 5912.231409916683, 5927.229460170151, 5931.970340148272, 5932.317783454958, 3904.082540603013, 4028.71798974069, 4035.8183881724804, 4056.959430405658, 4173.833046678099, 5708.372079071216, 5709.115087161496, 5753.0, 5755.53955683536, 5755.71221438918, 5467.6719396836315, 5524.696141712245, 5589.972050139723, 5592.049351610317, 5600.551955843604, 5297.867553311198, 5480.506754392124, 5522.806701765419, 5523.226748255328, 5581.441855814549, 5454.3454785426, 5471.945280547144, 5479.835604931858, 5499.945000549943, 5499.9825032369135, 5425.616467800685, 5571.832845014656, 5589.748461319169, 5592.384837667934, 5617.831465056055, 5448.746788238806, 5490.725463726878, 5490.945090549043, 5491.203775452457, 5493.670379777226], "value": 4193.808060665407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.5768769489083, 780.2041917244411, 784.8704963680993, 804.9235322644348, 828.7182357998281, 15868.285927133278, 16727.163641817908, 17042.573935651584, 17110.31558737652, 17155.742663860037, 15135.0, 15294.388224471008, 15298.617534561614, 15301.92349038256, 15320.923395383008, 653.3694984340111, 762.9198934111921, 781.9843603127935, 784.5763287824568, 792.3463142907096, 778.7352300217925, 783.5298820707587, 786.1273985875673, 786.9645865936018, 787.5196130360475, 688.6212583079312, 826.7189155687065, 827.6896163938524, 828.4408024583412, 828.6726742936567, 803.6825453945688, 806.1293802693107, 806.701520437436, 812.4434762187861, 815.1848151848152, 606.7694276175025, 607.1621162795315, 607.2530787131852, 607.2985701514757, 608.5405518833253, 15328.15695136767, 15435.3825846966, 15444.613884652861, 15455.690886182327, 15479.613009674735, 14461.27693615315, 14477.348519316656, 14823.925880370636, 14825.110493370432, 14958.40166393343, 12621.432035558422, 12641.557545485864, 12880.420381082873, 12889.419976101004, 13080.21518708871, 4617.12274667812, 4631.884202894921, 4664.95335046652, 4771.522847715235, 4790.856274311742, 75039.0, 76816.61591692005, 77744.61127694382, 77894.99999999943, 77961.0, 11594.708041009271, 11699.88300117005, 11901.10741694359, 12046.397680115959, 12230.449629766681, 20943.162273509195, 21366.78633213679, 21404.571908561742, 21440.892795536234, 21460.141594336365, 8531.06158322584, 8635.438696484709, 8733.170348816851, 8818.030016698158, 9069.229115525122, 4769.642276829251, 4808.35087263222, 4835.540623640749, 4890.682105663121, 4912.852614421573, 3578.177019285527, 3733.010752150682, 3753.3619284721663, 3763.736538442283, 3765.9246815063543, 626.6553395632384, 627.4071002902305, 640.324457697134, 642.5181114164377, 648.1509222917992, 687.5187368841831, 764.2815753191982, 789.4947233770391, 790.0637744273055, 790.4940837863771, 9602.519874006412, 10510.264281500222, 10511.894881051245, 10682.73293167677, 10883.33358327215, 688.1054628982303, 691.7855464805926, 736.2232844349263, 736.6427282767853, 737.5795796396003, 4860.781264843091, 5031.0, 5090.8404605100195, 5108.412532558729, 5139.511746384088, 121957.0, 123147.0, 123287.0, 124665.0, 126335.0, 82627.0, 84367.5781621088, 84679.0, 97306.99999999859, 103747.48126259321, 84877.57561212154, 87975.56012220026, 88217.55891220631, 88845.0, 88916.55541722379, 10349.482525873525, 10688.732781680521, 10695.518701658288, 10883.564657413615, 11025.61410350634, 46035.76982115068, 46105.30842037305, 47214.29178562393, 49308.75345623249, 52382.0, 70066.64966675134, 71359.0, 71364.0, 72148.63925680338, 73676.21104628182, 13407.396667149807, 13660.590182294547, 13719.245441500812, 13940.30298485092, 14182.14907105577, 15789.921050394674, 15952.122633255283, 15961.68076638484, 16017.839821602101, 17048.403305884236, 13939.16365018102, 14234.857651423767, 14904.25478726081, 15359.232038397811, 15476.690466190837, 14295.92852035733, 14388.568342949728, 14731.558053258419, 14832.7775083376, 15558.144302063496, 14533.27333633293, 14696.55910322692, 14768.77846832277, 15198.620034498783, 15605.0, 11566.363849988331, 11600.5359785611, 11766.941165294118, 11887.0, 11991.340476273539, 11386.259893106922, 11582.247153934968, 11747.530098795953, 11853.466594003117, 11904.166708330335], "value": 7807.4898780796875, "unit": "score"}], "name": "dromaeo_css", "value": 7332.1423345813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 110.0, 110.0, 112.0, 109.0, 109.0, 111.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 127.0, 174.0, 128.0, 128.0, 163.0, 124.0, 180.0, 128.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 159.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 128.0, 76.0, 75.0, 74.0, 74.0, 102.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 107.0, 85.0, 85.0, 86.0, 111.0, 83.0, 84.0, 132.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 54.0, 53.0, 61.0, 54.0, 57.0, 54.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 79.0, 79.0, 85.0, 80.0, 80.0, 83.0, 112.0, 79.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 124.0, 129.0, 121.0, 127.0, 120.0, 120.0, 133.0, 129.0, 124.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 167.0, 171.0, 169.0, 169.0, 170.0, 168.0, 164.0, 160.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 64.0, 64.0, 63.0, 63.0, 62.0, 63.0, 65.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1507.5, "alertThreshold": 2.0}]} 19:24:01 INFO - Return code: 0 19:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:01 INFO - # TBPL SUCCESS # 19:24:01 INFO - Running post-action listener: _resource_record_post_action 19:24:01 INFO - ##### 19:24:01 INFO - ##### Finished run-tests step (success) 19:24:01 INFO - ##### 19:24:01 INFO - Running post-run listener: _resource_record_post_run 19:24:01 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 551690240; Read time: 24; Write time: 425428 19:24:01 INFO - TinderboxPrint: CPU usage
13.1% 19:24:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 19:24:01 INFO - TinderboxPrint: I/O write bytes / time
551,690,240 / 425,428 19:24:01 INFO - TinderboxPrint: CPU idle
8,267.1 (86.8%) 19:24:01 INFO - TinderboxPrint: CPU user
1,204.4 (12.7%) 19:24:01 INFO - TinderboxPrint: Swap in / out
0 / 0 19:24:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256258048; Read time: 0; Write time: 256952 19:24:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295432192; Read time: 24; Write time: 168476 19:24:01 INFO - Running post-run listener: _upload_blobber_files 19:24:01 INFO - Blob upload gear active. 19:24:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:01 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 19:24:01 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:24:01 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:02 INFO - (blobuploader) - INFO - Done attempting. 19:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:03 INFO - (blobuploader) - INFO - Done attempting. 19:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:07 INFO - (blobuploader) - INFO - Done attempting. 19:24:07 INFO - (blobuploader) - INFO - Iteration through files over. 19:24:07 INFO - Return code: 0 19:24:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:24:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:24:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aad551751d23425e4c0c29b1fef2d5b16003243f9b54c57bab7275797a6683523b94bdd12cd5b27cf0a60b124b1b156a895edb41027bd0998910a3cd78be0d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e83e0e5f2ea7d181ddfb7590fe826e35f2b2097a4b12aacf41bddb42aae1bf83f509a620f13e0a5e2bdd6acb960fdab232540142a4ad7291363db0552d837f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57965b3ed5be81f8f9f4dc8dc2715b07921d2ec46861e6efef153f5b535a51c2ea7969f9ed2f443d468aedfa66218b91c79988056e0f55a1dc55deb05d343795"} 19:24:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:24:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:24:07 INFO - Contents: 19:24:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aad551751d23425e4c0c29b1fef2d5b16003243f9b54c57bab7275797a6683523b94bdd12cd5b27cf0a60b124b1b156a895edb41027bd0998910a3cd78be0d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e83e0e5f2ea7d181ddfb7590fe826e35f2b2097a4b12aacf41bddb42aae1bf83f509a620f13e0a5e2bdd6acb960fdab232540142a4ad7291363db0552d837f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57965b3ed5be81f8f9f4dc8dc2715b07921d2ec46861e6efef153f5b535a51c2ea7969f9ed2f443d468aedfa66218b91c79988056e0f55a1dc55deb05d343795"} 19:24:07 INFO - Running post-run listener: copy_logs_to_upload_dir 19:24:07 INFO - Copying logs to upload dir... 19:24:07 INFO - mkdir: /builds/slave/test/build/upload/logs 19:24:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.725339 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-18 19:24:06.978717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 19:24:06.981962) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 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-Inbound/sha512/aad551751d23425e4c0c29b1fef2d5b16003243f9b54c57bab7275797a6683523b94bdd12cd5b27cf0a60b124b1b156a895edb41027bd0998910a3cd78be0d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e83e0e5f2ea7d181ddfb7590fe826e35f2b2097a4b12aacf41bddb42aae1bf83f509a620f13e0a5e2bdd6acb960fdab232540142a4ad7291363db0552d837f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57965b3ed5be81f8f9f4dc8dc2715b07921d2ec46861e6efef153f5b535a51c2ea7969f9ed2f443d468aedfa66218b91c79988056e0f55a1dc55deb05d343795"} build_url:https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/GsALwAE2Q5ezgLgLX4scoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aad551751d23425e4c0c29b1fef2d5b16003243f9b54c57bab7275797a6683523b94bdd12cd5b27cf0a60b124b1b156a895edb41027bd0998910a3cd78be0d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e83e0e5f2ea7d181ddfb7590fe826e35f2b2097a4b12aacf41bddb42aae1bf83f509a620f13e0a5e2bdd6acb960fdab232540142a4ad7291363db0552d837f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57965b3ed5be81f8f9f4dc8dc2715b07921d2ec46861e6efef153f5b535a51c2ea7969f9ed2f443d468aedfa66218b91c79988056e0f55a1dc55deb05d343795"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 19:24:07.008334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:24:07.008757) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466297747.878710-1646341660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 19:24:07.093187) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 19:24:07.093556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 19:24:07.093870) ========= ========= Total master_lag: 0.17 =========