builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1465560205.63 results: success (0) buildid: 20160610023030 builduid: 7960a9e2ffba41f0adfd78a3aa8ac46b revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.628750) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.629277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.629577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.815934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.816236) ========= 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-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:03:26-- 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% 47.2M=0s 2016-06-10 05:03:26 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.908021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.908322) ========= 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-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018591 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.959955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:25.960272) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --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-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:03:26,469 truncating revision to first 12 chars 2016-06-10 05:03:26,469 Setting DEBUG logging. 2016-06-10 05:03:26,469 attempt 1/10 2016-06-10 05:03:26,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c0dce75ed0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:03:26,754 unpacking tar archive at: fx-team-9c0dce75ed0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.631461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.631831) ========= script_repo_revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.632207) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.632471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:03:26.643754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-10 05:03:26.644049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:27 INFO - MultiFileLogger online at 20160610 05:03:27 in /builds/slave/test 05:03:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:03:27 INFO - {'append_to_log': False, 05:03:27 INFO - 'base_work_dir': '/builds/slave/test', 05:03:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:03:27 INFO - 'branch': 'Fx-Team', 05:03:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:27 INFO - 'config_files': ('talos/linux_config.py',), 05:03:27 INFO - 'default_actions': ('clobber', 05:03:27 INFO - 'read-buildbot-config', 05:03:27 INFO - 'download-and-extract', 05:03:27 INFO - 'populate-webroot', 05:03:27 INFO - 'create-virtualenv', 05:03:27 INFO - 'install', 05:03:27 INFO - 'run-tests'), 05:03:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:27 INFO - 'download_minidump_stackwalk': True, 05:03:27 INFO - 'download_symbols': 'ondemand', 05:03:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:27 INFO - 'installer_path': 'installer.exe', 05:03:27 INFO - 'log_level': 'info', 05:03:27 INFO - 'log_name': 'talos', 05:03:27 INFO - 'log_to_console': True, 05:03:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:27 INFO - 'opt_config_files': (), 05:03:27 INFO - 'pip_index': False, 05:03:27 INFO - 'sps_profile': False, 05:03:27 INFO - 'sps_profile_interval': 0, 05:03:27 INFO - 'suite': 'dromaeojs', 05:03:27 INFO - 'system_bits': '32', 05:03:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:27 INFO - 'title': 'talos-linux64-ix-060', 05:03:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:27 INFO - 'use_talos_json': True, 05:03:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:03:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:27 INFO - 'work_dir': 'build'} 05:03:27 INFO - ##### 05:03:27 INFO - ##### Running clobber step. 05:03:27 INFO - ##### 05:03:27 INFO - Running pre-action listener: _resource_record_pre_action 05:03:27 INFO - Running main action method: clobber 05:03:27 INFO - rmtree: /builds/slave/test/build 05:03:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:03:28 INFO - Running post-action listener: _resource_record_post_action 05:03:28 INFO - ##### 05:03:28 INFO - ##### Finished clobber step (success) 05:03:28 INFO - ##### 05:03:28 INFO - ##### 05:03:28 INFO - ##### Running read-buildbot-config step. 05:03:28 INFO - ##### 05:03:28 INFO - Running pre-action listener: _resource_record_pre_action 05:03:28 INFO - Running main action method: read_buildbot_config 05:03:28 INFO - Using buildbot properties: 05:03:28 INFO - { 05:03:28 INFO - "project": "", 05:03:28 INFO - "product": "firefox", 05:03:28 INFO - "script_repo_revision": "production", 05:03:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:03:28 INFO - "repository": "", 05:03:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:03:28 INFO - "buildid": "20160610023030", 05:03:28 INFO - "pgo_build": "True", 05:03:28 INFO - "basedir": "/builds/slave/test", 05:03:28 INFO - "buildnumber": 177, 05:03:28 INFO - "slavename": "talos-linux64-ix-060", 05:03:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:03:28 INFO - "platform": "ubuntu64_hw", 05:03:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:28 INFO - "branch": "fx-team", 05:03:28 INFO - "repo_path": "integration/fx-team", 05:03:28 INFO - "revision": "9c0dce75ed0c21e0b05ba72c348da23b27e80888", 05:03:28 INFO - "stage_platform": "linux64-pgo", 05:03:28 INFO - "builduid": "7960a9e2ffba41f0adfd78a3aa8ac46b", 05:03:28 INFO - "slavebuilddir": "test" 05:03:28 INFO - } 05:03:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:03:28 INFO - Running post-action listener: _resource_record_post_action 05:03:28 INFO - ##### 05:03:28 INFO - ##### Finished read-buildbot-config step (success) 05:03:28 INFO - ##### 05:03:28 INFO - ##### 05:03:28 INFO - ##### Running download-and-extract step. 05:03:28 INFO - ##### 05:03:28 INFO - Running pre-action listener: _resource_record_pre_action 05:03:28 INFO - Running main action method: download_and_extract 05:03:28 INFO - mkdir: /builds/slave/test/build/tests 05:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:28 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:30 INFO - Downloaded 1361 bytes. 05:03:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:30 INFO - Using the following test package requirements: 05:03:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:03:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'jsshell-linux-x86_64.zip'], 05:03:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:30 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:35 INFO - Downloaded 24452446 bytes. 05:03:35 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'] 05:03:35 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 05:03:37 INFO - Return code: 0 05:03:37 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 05: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')]} 05:03:37 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:38 INFO - Downloaded 24452446 bytes. 05:03:38 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'] 05:03:38 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 05:03:39 INFO - Return code: 0 05: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')]} 05:03:39 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:41 INFO - Downloaded 10833377 bytes. 05:03:41 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'] 05:03:41 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 05:03:41 INFO - Return code: 0 05:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:41 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:03:42 INFO - Downloaded 59292349 bytes. 05:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:42 INFO - mkdir: /builds/slave/test/properties 05:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:42 INFO - Contents: 05:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:43 INFO - Running post-action listener: _resource_record_post_action 05:03:43 INFO - Running post-action listener: set_extra_try_arguments 05:03:43 INFO - ##### 05:03:43 INFO - ##### Finished download-and-extract step (success) 05:03:43 INFO - ##### 05:03:43 INFO - ##### 05:03:43 INFO - ##### Running populate-webroot step. 05:03:43 INFO - ##### 05:03:43 INFO - Running pre-action listener: _resource_record_pre_action 05:03:43 INFO - Running main action method: populate_webroot 05:03:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:43 INFO - '--tppagecycles', 05:03:43 INFO - '7'], 05:03:43 INFO - 'tests': ['tsvgm']}}, 05:03:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['damp', 'tps']}, 05:03:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'tests': ['damp', 'tps']}, 05:03:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['dromaeo_dom']}, 05:03:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['a11yr', 05:03:43 INFO - 'ts_paint', 05:03:43 INFO - 'tpaint', 05:03:43 INFO - 'sessionrestore', 05:03:43 INFO - 'sessionrestore_no_auto_restore', 05:03:43 INFO - 'tabpaint']}, 05:03:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['tsvgx', 05:03:43 INFO - 'tsvgr_opacity', 05:03:43 INFO - 'tart', 05:03:43 INFO - 'tscrollx', 05:03:43 INFO - 'cart']}, 05:03:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:43 INFO - 'tsvgr_opacity', 05:03:43 INFO - 'tart', 05:03:43 INFO - 'tscrollx', 05:03:43 INFO - 'cart']}, 05:03:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'talos_options': ['--disable-e10s'], 05:03:43 INFO - 'tests': ['tp5o']}, 05:03:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'tests': ['tp5o']}, 05:03:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'talos_options': ['--disable-e10s', 05:03:43 INFO - '--xperf_path', 05:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:43 INFO - 'tests': ['tp5n']}, 05:03:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:43 INFO - 'talos_options': ['--xperf_path', 05:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:43 INFO - 'tests': ['tp5n']}}, 05:03:43 INFO - 'talos.zip': {'path': '', 05:03:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:43 INFO - Running post-action listener: _resource_record_post_action 05:03:43 INFO - ##### 05:03:43 INFO - ##### Finished populate-webroot step (success) 05:03:43 INFO - ##### 05:03:43 INFO - ##### 05:03:43 INFO - ##### Running create-virtualenv step. 05:03:43 INFO - ##### 05:03:43 INFO - Running pre-action listener: _resource_record_pre_action 05:03:43 INFO - Running main action method: create_virtualenv 05:03:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:43 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 05:03:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:43 INFO - Using real prefix '/usr' 05:03:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:45 INFO - Installing pip.................done. 05:03:45 INFO - Return code: 0 05:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05: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 05: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 05:03:45 INFO - Using env: {'DISPLAY': ':0', 05:03:45 INFO - 'HOME': '/home/cltbld', 05:03:45 INFO - 'LANG': 'en_US.UTF-8', 05:03:45 INFO - 'LANGUAGE': 'en_US:en', 05:03:45 INFO - 'LOGNAME': 'cltbld', 05:03:45 INFO - 'MAIL': '/var/mail/cltbld', 05:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:45 INFO - 'MOZ_NO_REMOTE': '1', 05:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:45 INFO - 'NO_EM_RESTART': '1', 05:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:45 INFO - 'PWD': '/builds/slave/test', 05:03:45 INFO - 'SHELL': '/bin/bash', 05:03:45 INFO - 'SHLVL': '1', 05:03:45 INFO - 'TERM': 'linux', 05:03:45 INFO - 'TMOUT': '86400', 05:03:45 INFO - 'USER': 'cltbld', 05:03:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:45 INFO - '_': '/tools/buildbot/bin/python'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 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 05:03:46 INFO - Cleaning up... 05:03:46 INFO - Return code: 0 05:03:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03:46 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')]} 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 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')]} 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05:03:46 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 05:03:46 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 05:03:46 INFO - Using env: {'DISPLAY': ':0', 05:03:46 INFO - 'HOME': '/home/cltbld', 05:03:46 INFO - 'LANG': 'en_US.UTF-8', 05:03:46 INFO - 'LANGUAGE': 'en_US:en', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MAIL': '/var/mail/cltbld', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SHLVL': '1', 05:03:46 INFO - 'TERM': 'linux', 05:03:46 INFO - 'TMOUT': '86400', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - '_': '/tools/buildbot/bin/python'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 INFO - Downloading/unpacking psutil>=3.1.1 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:48 INFO - Installing collected packages: psutil 05:03:48 INFO - Running setup.py install for psutil 05:03:48 INFO - building 'psutil._psutil_linux' extension 05:03:48 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 05: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 05:03:48 INFO - building 'psutil._psutil_posix' extension 05: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 05: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 05:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:48 INFO - Successfully installed psutil 05:03:48 INFO - Cleaning up... 05:03:48 INFO - Return code: 0 05:03:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05: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 05: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 05:03:48 INFO - Using env: {'DISPLAY': ':0', 05:03:48 INFO - 'HOME': '/home/cltbld', 05:03:48 INFO - 'LANG': 'en_US.UTF-8', 05:03:48 INFO - 'LANGUAGE': 'en_US:en', 05:03:48 INFO - 'LOGNAME': 'cltbld', 05:03:48 INFO - 'MAIL': '/var/mail/cltbld', 05:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:48 INFO - 'MOZ_NO_REMOTE': '1', 05:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:48 INFO - 'NO_EM_RESTART': '1', 05:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:48 INFO - 'PWD': '/builds/slave/test', 05:03:48 INFO - 'SHELL': '/bin/bash', 05:03:48 INFO - 'SHLVL': '1', 05:03:48 INFO - 'TERM': 'linux', 05:03:48 INFO - 'TMOUT': '86400', 05:03:48 INFO - 'USER': 'cltbld', 05:03:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:48 INFO - '_': '/tools/buildbot/bin/python'} 05:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:51 INFO - Installing collected packages: mozsystemmonitor 05:03:51 INFO - Running setup.py install for mozsystemmonitor 05:03:51 INFO - Successfully installed mozsystemmonitor 05:03:51 INFO - Cleaning up... 05:03:51 INFO - Return code: 0 05:03:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05:03:51 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 05:03:51 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 05:03:51 INFO - Using env: {'DISPLAY': ':0', 05:03:51 INFO - 'HOME': '/home/cltbld', 05:03:51 INFO - 'LANG': 'en_US.UTF-8', 05:03:51 INFO - 'LANGUAGE': 'en_US:en', 05:03:51 INFO - 'LOGNAME': 'cltbld', 05:03:51 INFO - 'MAIL': '/var/mail/cltbld', 05:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:51 INFO - 'MOZ_NO_REMOTE': '1', 05:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:51 INFO - 'NO_EM_RESTART': '1', 05:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:51 INFO - 'PWD': '/builds/slave/test', 05:03:51 INFO - 'SHELL': '/bin/bash', 05:03:51 INFO - 'SHLVL': '1', 05:03:51 INFO - 'TERM': 'linux', 05:03:51 INFO - 'TMOUT': '86400', 05:03:51 INFO - 'USER': 'cltbld', 05:03:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:51 INFO - '_': '/tools/buildbot/bin/python'} 05:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:51 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 05:03:51 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 05:03:51 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 05:03:51 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 05:03:51 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 05:03:51 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 05:03:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05: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 05: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 05: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 05: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 05: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 05: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 05:03:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:53 INFO - warning: no files found matching '*.txt' 05:03:53 INFO - no previously-included directories found matching 'build' 05:03:53 INFO - no previously-included directories found matching 'dist' 05:03:53 INFO - no previously-included directories found matching '.git*' 05:03:53 INFO - Installing collected packages: jsonschema, functools32 05:03:53 INFO - Running setup.py install for functools32 05:03:53 INFO - warning: no files found matching '*.txt' 05:03:53 INFO - no previously-included directories found matching 'build' 05:03:53 INFO - no previously-included directories found matching 'dist' 05:03:53 INFO - no previously-included directories found matching '.git*' 05:03:53 INFO - Successfully installed jsonschema functools32 05:03:53 INFO - Cleaning up... 05:03:53 INFO - Return code: 0 05:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05: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 05: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 05:03:53 INFO - Using env: {'DISPLAY': ':0', 05:03:53 INFO - 'HOME': '/home/cltbld', 05:03:53 INFO - 'LANG': 'en_US.UTF-8', 05:03:53 INFO - 'LANGUAGE': 'en_US:en', 05:03:53 INFO - 'LOGNAME': 'cltbld', 05:03:53 INFO - 'MAIL': '/var/mail/cltbld', 05:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:53 INFO - 'MOZ_NO_REMOTE': '1', 05:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:53 INFO - 'NO_EM_RESTART': '1', 05:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:53 INFO - 'PWD': '/builds/slave/test', 05:03:53 INFO - 'SHELL': '/bin/bash', 05:03:53 INFO - 'SHLVL': '1', 05:03:53 INFO - 'TERM': 'linux', 05:03:53 INFO - 'TMOUT': '86400', 05:03:53 INFO - 'USER': 'cltbld', 05:03:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:53 INFO - '_': '/tools/buildbot/bin/python'} 05:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05: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 05: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 05: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 05: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 05: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 05: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 05:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:56 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 05:03:56 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 05:03:56 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 05:03:56 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 05:03:56 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 05:03:56 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 05:03:56 INFO - Downloading docopt-0.6.1.tar.gz 05:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:56 INFO - Running setup.py install for blobuploader 05:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:56 INFO - Running setup.py install for requests 05:03:57 INFO - Running setup.py install for docopt 05:03:57 INFO - Successfully installed blobuploader requests docopt 05:03:57 INFO - Cleaning up... 05:03:57 INFO - Return code: 0 05:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05:03:57 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 05:03:57 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 05:03:57 INFO - Using env: {'DISPLAY': ':0', 05:03:57 INFO - 'HOME': '/home/cltbld', 05:03:57 INFO - 'LANG': 'en_US.UTF-8', 05:03:57 INFO - 'LANGUAGE': 'en_US:en', 05:03:57 INFO - 'LOGNAME': 'cltbld', 05:03:57 INFO - 'MAIL': '/var/mail/cltbld', 05:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:57 INFO - 'MOZ_NO_REMOTE': '1', 05:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:57 INFO - 'NO_EM_RESTART': '1', 05:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:57 INFO - 'PWD': '/builds/slave/test', 05:03:57 INFO - 'SHELL': '/bin/bash', 05:03:57 INFO - 'SHLVL': '1', 05:03:57 INFO - 'TERM': 'linux', 05:03:57 INFO - 'TMOUT': '86400', 05:03:57 INFO - 'USER': 'cltbld', 05:03:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:57 INFO - '_': '/tools/buildbot/bin/python'} 05:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:57 INFO - Running setup.py (path:/tmp/pip-uPeJqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:57 INFO - Running setup.py (path:/tmp/pip-yjsxie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:57 INFO - Running setup.py (path:/tmp/pip-xzbz1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:57 INFO - Running setup.py (path:/tmp/pip-psToT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:57 INFO - Running setup.py (path:/tmp/pip-zo9ZW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:57 INFO - Running setup.py (path:/tmp/pip-yxzdy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:57 INFO - Running setup.py (path:/tmp/pip-Wih550-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:58 INFO - Running setup.py (path:/tmp/pip-al5_vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:58 INFO - Running setup.py (path:/tmp/pip-iPUaLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:58 INFO - Running setup.py (path:/tmp/pip-8xI5uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:58 INFO - Running setup.py (path:/tmp/pip-znc3TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:58 INFO - Running setup.py (path:/tmp/pip-UW8WJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:58 INFO - Running setup.py (path:/tmp/pip-NRfl15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:58 INFO - Running setup.py (path:/tmp/pip-xjD5Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:58 INFO - Running setup.py (path:/tmp/pip-X5D07I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:58 INFO - Running setup.py (path:/tmp/pip-6wPLbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:58 INFO - Running setup.py (path:/tmp/pip-0quewn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:58 INFO - Running setup.py install for manifestparser 05:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:58 INFO - Running setup.py install for mozcrash 05:03:58 INFO - Running setup.py install for mozdebug 05:03:59 INFO - Running setup.py install for mozdevice 05:03:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for mozfile 05:03:59 INFO - Running setup.py install for mozhttpd 05:03:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for mozinfo 05:03:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for mozInstall 05:03:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for mozleak 05:03:59 INFO - Running setup.py install for mozlog 05:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for moznetwork 05:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:59 INFO - Running setup.py install for mozprocess 05:03:59 INFO - Running setup.py install for mozprofile 05:04:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:00 INFO - Running setup.py install for mozrunner 05:04:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:00 INFO - Running setup.py install for mozscreenshot 05:04:00 INFO - Running setup.py install for moztest 05:04:00 INFO - Running setup.py install for mozversion 05:04:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:00 INFO - Cleaning up... 05:04:00 INFO - Return code: 0 05:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:00 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')]} 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:00 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')]} 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:00 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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05:04:00 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 05:04:00 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 05:04:00 INFO - Using env: {'DISPLAY': ':0', 05:04:00 INFO - 'HOME': '/home/cltbld', 05:04:00 INFO - 'LANG': 'en_US.UTF-8', 05:04:00 INFO - 'LANGUAGE': 'en_US:en', 05:04:00 INFO - 'LOGNAME': 'cltbld', 05:04:00 INFO - 'MAIL': '/var/mail/cltbld', 05:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:00 INFO - 'MOZ_NO_REMOTE': '1', 05:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:00 INFO - 'NO_EM_RESTART': '1', 05:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:00 INFO - 'PWD': '/builds/slave/test', 05:04:00 INFO - 'SHELL': '/bin/bash', 05:04:00 INFO - 'SHLVL': '1', 05:04:00 INFO - 'TERM': 'linux', 05:04:00 INFO - 'TMOUT': '86400', 05:04:00 INFO - 'USER': 'cltbld', 05:04:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:00 INFO - '_': '/tools/buildbot/bin/python'} 05:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:00 INFO - Running setup.py (path:/tmp/pip-ygy1ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05: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)) 05:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:00 INFO - Running setup.py (path:/tmp/pip-uO4YYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05: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)) 05:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:00 INFO - Running setup.py (path:/tmp/pip-mgXwfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05: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)) 05:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:00 INFO - Running setup.py (path:/tmp/pip-JSVVlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:01 INFO - Running setup.py (path:/tmp/pip-9Ju6MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:01 INFO - Running setup.py (path:/tmp/pip-1LKLeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:01 INFO - Running setup.py (path:/tmp/pip-6P6FOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:01 INFO - Running setup.py (path:/tmp/pip-qsuXdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:01 INFO - Running setup.py (path:/tmp/pip-e5TN1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:01 INFO - Running setup.py (path:/tmp/pip-6j3Osh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:01 INFO - Running setup.py (path:/tmp/pip-ZdM_qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:01 INFO - Running setup.py (path:/tmp/pip-w0Snp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:01 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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:01 INFO - Running setup.py (path:/tmp/pip-hH1zUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05: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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:01 INFO - Running setup.py (path:/tmp/pip-uBAUyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05: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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:01 INFO - Running setup.py (path:/tmp/pip-Kn1rdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05: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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:01 INFO - Running setup.py (path:/tmp/pip-w3Mcc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05: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)) 05:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:01 INFO - Running setup.py (path:/tmp/pip-E1pnOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05: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)) 05: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)) 05: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)) 05: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)) 05: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)) 05: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)) 05:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05: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 05: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 05: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 05: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 05: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 05: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 05:04:03 INFO - Downloading blessings-1.6.tar.gz 05:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:03 INFO - Installing collected packages: blessings 05:04:03 INFO - Running setup.py install for blessings 05:04:04 INFO - Successfully installed blessings 05:04:04 INFO - Cleaning up... 05:04:04 INFO - Return code: 0 05:04:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:04 INFO - Reading from file tmpfile_stdout 05:04:04 INFO - Current package versions: 05:04:04 INFO - argparse == 1.2.1 05:04:04 INFO - blessings == 1.6 05:04:04 INFO - blobuploader == 1.2.4 05:04:04 INFO - docopt == 0.6.1 05:04:04 INFO - functools32 == 3.2.3-2 05:04:04 INFO - jsonschema == 2.5.1 05:04:04 INFO - manifestparser == 1.1 05:04:04 INFO - mozInstall == 1.12 05:04:04 INFO - mozcrash == 0.17 05:04:04 INFO - mozdebug == 0.1 05:04:04 INFO - mozdevice == 0.48 05:04:04 INFO - mozfile == 1.2 05:04:04 INFO - mozhttpd == 0.7 05:04:04 INFO - mozinfo == 0.9 05:04:04 INFO - mozleak == 0.1 05:04:04 INFO - mozlog == 3.2 05:04:04 INFO - moznetwork == 0.27 05:04:04 INFO - mozprocess == 0.22 05:04:04 INFO - mozprofile == 0.28 05:04:04 INFO - mozrunner == 6.11 05:04:04 INFO - mozscreenshot == 0.1 05:04:04 INFO - mozsystemmonitor == 0.3 05:04:04 INFO - moztest == 0.7 05:04:04 INFO - mozversion == 1.4 05:04:04 INFO - psutil == 3.1.1 05:04:04 INFO - requests == 1.2.3 05:04:04 INFO - wsgiref == 0.1.2 05:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05: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')]} 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:04 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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05:04:04 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 05:04:04 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 05:04:04 INFO - Using env: {'DISPLAY': ':0', 05:04:04 INFO - 'HOME': '/home/cltbld', 05:04:04 INFO - 'LANG': 'en_US.UTF-8', 05:04:04 INFO - 'LANGUAGE': 'en_US:en', 05:04:04 INFO - 'LOGNAME': 'cltbld', 05:04:04 INFO - 'MAIL': '/var/mail/cltbld', 05:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:04 INFO - 'MOZ_NO_REMOTE': '1', 05:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:04 INFO - 'NO_EM_RESTART': '1', 05:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:04 INFO - 'PWD': '/builds/slave/test', 05:04:04 INFO - 'SHELL': '/bin/bash', 05:04:04 INFO - 'SHLVL': '1', 05:04:04 INFO - 'TERM': 'linux', 05:04:04 INFO - 'TMOUT': '86400', 05:04:04 INFO - 'USER': 'cltbld', 05:04:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:04 INFO - '_': '/tools/buildbot/bin/python'} 05:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 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)) 05:04:04 INFO - Cleaning up... 05:04:04 INFO - Return code: 0 05:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05: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')]} 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05: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', 'jsonschema'] in /builds/slave/test/build 05: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 jsonschema 05:04:04 INFO - Using env: {'DISPLAY': ':0', 05:04:04 INFO - 'HOME': '/home/cltbld', 05:04:04 INFO - 'LANG': 'en_US.UTF-8', 05:04:04 INFO - 'LANGUAGE': 'en_US:en', 05:04:04 INFO - 'LOGNAME': 'cltbld', 05:04:04 INFO - 'MAIL': '/var/mail/cltbld', 05:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:04 INFO - 'MOZ_NO_REMOTE': '1', 05:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:04 INFO - 'NO_EM_RESTART': '1', 05:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:04 INFO - 'PWD': '/builds/slave/test', 05:04:04 INFO - 'SHELL': '/bin/bash', 05:04:04 INFO - 'SHLVL': '1', 05:04:04 INFO - 'TERM': 'linux', 05:04:04 INFO - 'TMOUT': '86400', 05:04:04 INFO - 'USER': 'cltbld', 05:04:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:04 INFO - '_': '/tools/buildbot/bin/python'} 05:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:04 INFO - Cleaning up... 05:04:04 INFO - Return code: 0 05:04:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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 0x7fce59303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, '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-1465559889.698925-716717929', '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 05: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 05: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 05:04:04 INFO - Using env: {'DISPLAY': ':0', 05:04:04 INFO - 'HOME': '/home/cltbld', 05:04:04 INFO - 'LANG': 'en_US.UTF-8', 05:04:04 INFO - 'LANGUAGE': 'en_US:en', 05:04:04 INFO - 'LOGNAME': 'cltbld', 05:04:04 INFO - 'MAIL': '/var/mail/cltbld', 05:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:04 INFO - 'MOZ_NO_REMOTE': '1', 05:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:04 INFO - 'NO_EM_RESTART': '1', 05:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:04 INFO - 'PWD': '/builds/slave/test', 05:04:04 INFO - 'SHELL': '/bin/bash', 05:04:04 INFO - 'SHLVL': '1', 05:04:04 INFO - 'TERM': 'linux', 05:04:04 INFO - 'TMOUT': '86400', 05:04:04 INFO - 'USER': 'cltbld', 05:04:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:04 INFO - '_': '/tools/buildbot/bin/python'} 05:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:04 INFO - Downloading/unpacking flake8 05: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 05: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 05: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 05: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 05:04:05 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 05:04:05 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 05:04:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05: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 05: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 05: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 05: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 05: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 05: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 05:04:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 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 05:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:07 INFO - no previously-included directories found matching 'docs/_build' 05:04:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:07 INFO - Running setup.py install for pep8 05:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:07 INFO - no previously-included directories found matching 'docs/_build' 05:04:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:07 INFO - Cleaning up... 05:04:07 INFO - Return code: 0 05:04:07 INFO - Running post-action listener: _resource_record_post_action 05:04:07 INFO - Running post-action listener: _start_resource_monitoring 05:04:07 INFO - Starting resource monitoring. 05:04:07 INFO - ##### 05:04:07 INFO - ##### Finished create-virtualenv step (success) 05:04:07 INFO - ##### 05:04:07 INFO - ##### 05:04:07 INFO - ##### Running install step. 05:04:07 INFO - ##### 05:04:07 INFO - Running pre-action listener: _resource_record_pre_action 05:04:07 INFO - Running main action method: install 05:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:08 INFO - Reading from file tmpfile_stdout 05:04:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:08 INFO - Reading from file tmpfile_stdout 05:04:08 INFO - Output received: 05:04:08 INFO - Usage: mozinstall [options] installer 05:04:08 INFO - Options: 05:04:08 INFO - -h, --help show this help message and exit 05:04:08 INFO - -d DEST, --destination=DEST 05:04:08 INFO - Directory to install application into. [default: 05:04:08 INFO - "/builds/slave/test"] 05:04:08 INFO - --app=APP Application being installed. [default: firefox] 05:04:08 INFO - mkdir: /builds/slave/test/build/application 05:04:08 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'] 05:04:08 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 05:04:25 INFO - Reading from file tmpfile_stdout 05:04:25 INFO - Output received: 05:04:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:04:25 INFO - Running post-action listener: _resource_record_post_action 05:04:25 INFO - ##### 05:04:25 INFO - ##### Finished install step (success) 05:04:25 INFO - ##### 05:04:25 INFO - ##### 05:04:25 INFO - ##### Running run-tests step. 05:04:25 INFO - ##### 05:04:25 INFO - Running pre-action listener: _resource_record_pre_action 05:04:25 INFO - Running main action method: run_tests 05:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:25 INFO - Python 2.7.3 05:04:25 INFO - Return code: 0 05:04:25 INFO - grabbing minidump binary from tooltool 05:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:25 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 0x10ec1c0>, '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 0x10ed0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:25 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 05:04:25 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 05:04:25 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 05:04:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:25 INFO - Return code: 0 05:04:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:04:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:04:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:04:26 INFO - Return code: 0 05:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:04:26 INFO - Using env: {'DISPLAY': ':0', 05:04:26 INFO - 'HOME': '/home/cltbld', 05:04:26 INFO - 'LANG': 'en_US.UTF-8', 05:04:26 INFO - 'LANGUAGE': 'en_US:en', 05:04:26 INFO - 'LOGNAME': 'cltbld', 05:04:26 INFO - 'MAIL': '/var/mail/cltbld', 05:04:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:26 INFO - 'MOZ_NO_REMOTE': '1', 05:04:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:26 INFO - 'NO_EM_RESTART': '1', 05:04:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:26 INFO - 'PWD': '/builds/slave/test', 05:04:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:26 INFO - 'SHELL': '/bin/bash', 05:04:26 INFO - 'SHLVL': '1', 05:04:26 INFO - 'TERM': 'linux', 05:04:26 INFO - 'TMOUT': '86400', 05:04:26 INFO - 'USER': 'cltbld', 05:04:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465559889.698925-716717929', 05:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:26 INFO - '_': '/tools/buildbot/bin/python'} 05:04:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:04:26 INFO - mozversion application_buildid: 20160610023030 05:04:26 INFO - mozversion application_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:04:26 INFO - mozversion application_display_name: Nightly 05:04:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:26 INFO - mozversion application_name: Firefox 05:04:26 INFO - mozversion application_remotingname: firefox 05:04:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:26 INFO - mozversion application_vendor: Mozilla 05:04:26 INFO - mozversion application_version: 50.0a1 05:04:26 INFO - mozversion platform_buildid: 20160610023030 05:04:26 INFO - mozversion platform_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:04:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:26 INFO - mozversion platform_version: 50.0a1 05:04:26 INFO - using testdate: 1465560266 05:04:26 INFO - actual date: 1465560266 05:04:26 INFO - starting webserver on 'localhost:58828' 05:04:26 INFO - SUITE-START | Running 2 tests 05:04:26 INFO - TEST-START | dromaeo_css 05:04:26 INFO - operating with platform_type : linux_ 05:04:26 INFO - Initialising browser for dromaeo_css test... 05:04:26 INFO - TEST-INFO | started process 25564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphF359w/profile http://localhost:58828/getInfo.html) 05:04:30 INFO - PROCESS | 25564 | __metrics Screen width/height:1600/1200 05:04:30 INFO - PROCESS | 25564 | colorDepth:24 05:04:30 INFO - PROCESS | 25564 | Browser inner width/height: 1024/697 05:04:30 INFO - PROCESS | 25564 | __metrics 05:04:31 ERROR - PROCESS | 25564 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:04:31 INFO - PROCESS | 25564 | console.error: PushService: 05:04:31 INFO - PROCESS | 25564 | stateChangeProcessEnqueue: Error transitioning state 05:04:31 INFO - PROCESS | 25564 | UnknownError 05:04:32 INFO - TEST-INFO | 25564: exit 0 05:04:32 INFO - Browser initialized. 05:04:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:32 INFO - TEST-INFO | started process 25649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphF359w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:44 INFO - PROCESS | 25649 | RSS: Main: 173178880 05:04:44 INFO - PROCESS | 25649 | 05:05:35 INFO - PROCESS | 25649 | 1465560335866 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] 05:07:43 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58828/tests/dromaeo/cssquery-ext.html) 05:07:44 INFO - PROCESS | 25649 | RSS: Main: 264433664 05:07:44 INFO - PROCESS | 25649 | 05:10:46 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-ext.html (next: http://localhost:58828/tests/dromaeo/cssquery-jquery.html) 05:10:47 INFO - PROCESS | 25649 | RSS: Main: 271523840 05:10:47 INFO - PROCESS | 25649 | 05:13:49 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58828/tests/dromaeo/cssquery-mootools.html) 05:13:50 INFO - PROCESS | 25649 | RSS: Main: 266264576 05:13:50 INFO - PROCESS | 25649 | 05:16:52 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58828/tests/dromaeo/cssquery-prototype.html) 05:16:52 INFO - PROCESS | 25649 | RSS: Main: 259710976 05:16:52 INFO - PROCESS | 25649 | 05:19:55 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58828/tests/dromaeo/cssquery-yui.html) 05:19:56 INFO - PROCESS | 25649 | RSS: Main: 233484288 05:19:56 INFO - PROCESS | 25649 | 05:22:58 INFO - PROCESS | 25649 | Cycle 1(1): loaded http://localhost:58828/tests/dromaeo/cssquery-yui.html (next: http://localhost:58828/tests/dromaeo/cssquery-dojo.html) 05:22:59 INFO - PROCESS | 25649 | RSS: Main: 292941824 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | __start_tp_report 05:22:59 INFO - PROCESS | 25649 | _x_x_mozilla_page_load 05:22:59 INFO - PROCESS | 25649 | _x_x_mozilla_page_load_details 05:22:59 INFO - PROCESS | 25649 | |i|pagename|runs| 05:22:59 INFO - PROCESS | 25649 | |0;dojo.html;3070.984645076774;3072.324088700486;3091.1653853459575;3113.9844300778523;3123.203583086313;5127.615428842842;5177.715225662587;5321.414644389114;5401.783928642854;5433.049216387131;5234.241035049916;5246.973765131169;5298.894022119555;5319.601029922752;5331.733413329337;4773.856784296477;4783.928241076386;4980.477049909761;5028.170351891933;5089.592832573404;5000.19996800512;5008.549230569248;5011.32347133136;5030.6981581105065;5040.294358789773;4670.042641258534;4704.341392205077;4809.374781278429;4814.927776083362;4880.487548807359;4881.487443818419;4891.0951473977075;4892.828750993698;4896.2410826321975;4938.160512712848;4837.516248375135;4859.635527335428;4875.609951203895;4890.70655760652;4939.061578300111;5188.299579556749;5234.8429547113265;5264.368275806889;5315.946840531623;5371.086915224421;5612.887742245132;5653;5657.717114144318;5660.066089095294;5729.226554415184;5749.59752817303;5762.452567006169;5776.075827867563;5777.046787280094;5779.508741756956;5287.603429742785;5350.411454739976;5386.569074474032;5402.675839449606;5487.451254874481;5964.015937370285;5965.791197308074;5976.342602313742;5985;5986.401359864066;5545.085060964976;5749.798757043483;5757.88484230313;5759.424057594207;5764.423557644286;5615.326160860641;5668.971655141698;5669.092945128842;5713.714314284269;5717.42825717425;5673.744681489343;5680.375158732536;5685.232493613309;5685.857853553694;5686.5735069869925;5514.6139770216505;5624.437556244425;5692.686902220417;5701.4013528579735;5702.087665973508;4382.517923028464;4384.627306678968;4396.076823867023;4425.800838962255;4431.357453169272;3878.612138786099;3894.299026175259;3912.7847968361443;3928.7249892507252;3948.58539853317;5242.344706911636;5306.389765177054;5381.031414345455;5407.324084489439;5443.047466693313;5650.3502097258515;5687.090065589486;5708.828735137952;5708.914366284509;5756.30924289088;5375.7849686012905;5378.166384210375;5384.811531596453;5391.16436952273;5401.054815407288;4729.266963620645;4761.595264402565;4786.114568804782;4832.661713680009;4865.197242454955;5874.206982057368;5895.55783316253;5898.852528686732;5900.085486749561;5958.255218097738;5696.943030569641;5705.971470142623;5705.971470142623;5707.429257074259;5708.686022268815;5662.207290979184;5684.63049901755;5708.686022268815;5747.109198074305;5870.589058765845;5483.341998960151;5497.147942068986;5504.779808807763;5506.862328441821;5526.447355264441;5683.204351390726;5705.4579814917515;5721.971390143189;5737.397573254748;5750.741216645178;5441.619086663895;5542.75057622416;5560.165975103767;5591.9720401397735;5641.041023026013;5617.073182924772;5619.803306884403;5619.971900140473;5622.353429355513;5627.803026894039;5358.33020872391;5529.944700552943;5536.944630553643;5537.031019571639;5543.528800051879;5553.527950124285;5572.832815015556;5579.19101730255;5665.773369065191;5666.093425052137;5452.781888724407;5461;5464.972675136599;5466.972665136649;5488.094464413327 05:22:59 INFO - PROCESS | 25649 | |1;ext.html;607.911852781347;610.8075956073836;611.4955161991356;615.031325662082;615.7998650438609;31275.530867036985;42998.140037199235;43962.7801860991;44006.779966100126;47920.52079479204;45801.770991145;46101;46117.53882461174;46141.7692911535;46172.769136154355;8851.91148088519;8976.461412315282;9007.054259302744;9008.729738107868;9042.367034307601;8882.467051976902;8974.955125224365;8976.685815996441;8979.685711000116;8981.77545561363;8956.19394254517;8968.551572421386;9011.27909767217;9011.684591039315;9015.729528114167;8956.910430895672;8979.326550508738;9011.639534418615;9024.503652299121;9024.77438064047;8853.73438796837;8912.465252084896;8927.464352138892;8932.910670893338;8944.23973962214;42768.1446371074;43007.35488967668;43089.78455107704;43110;43373.13253734939;3674.0447483654175;3702.9444558331647;3726.105734623698;3781.810909454516;3826.789526576037;32781.02809164393;32921.3415731684;33312.666873331196;33438.83280583606;34277.31445371079;4211.527694510637;4421.778911054466;4470.441194850644;4479.283314669638;4564.52072532386;377942;378488;378847;380319.09840450896;380613;58817.411825881194;59167.70416147978;59269;59287;59293.703531482926;62960;62973.42566435876;63028;63112;63215.6839215801;16709.83290167107;16856.241469133918;16895;16895.662086758442;16916.746248806277;13050.804237936438;13092.279924604238;13110.934445327903;13118.278494682883;13121.278329691768;15052.849471505364;16610.418635347705;16844.326226950783;16886;16918.323267069427;5491.336701699673;6366.490680745529;6451.161349024691;6569.934300657028;6675.46596272297;974.9561269742878;1013.5945621751358;1130.5364800431782;1159.2406973432414;1159.7042754097652;32153.678463215536;32703.345933081204;32783.1804204892;32846.507302390484;33193.502097468554;1083.5286650307141;1105.7622611138643;1145.169751929844;1163.2322667039714;1219.3781171602548;17179.742303865452;17277.840269966255;17368.39210627622;17402.825971740374;17458.563535911704;511559;512287;517294;518382;519716;59845;59957.70021149866;59976;60078;60118.39881601128;1243.521244320943;1337.5452346202337;1353.1678018018847;1361.7889227169806;1365.8429280632656;33012.50481242831;34719.47920781241;34760.47859282164;34782.045920704266;35299.82350088336;50838;51300.48699512957;51401.7429912848;51490.48509515007;51521.48478515167;315583;320155;320823;322444;322712;40711.79644101761;41798.791006044776;42621;42853;42912.35631465468;49660;50438.49561504338;50481;51250;51806.222906655676;41670.58329416788;42283.3657495144;42443.36334954917;43347.566524334354;43888.561114389726;41552;41579.16841663211;41916.37125443182;42509;42796.572034279256;41476.79261603673;42636.78681606572;43099.784501077294;43326.78336608297;43752.343714843664;36605.60732712092;37933.56826872632;38544.82417038138;38546.229075417774;38809.6119038806;28577.571336430385;29181.41637167202;29296.853515732284;29381.85309073441;29532.852335738186 05:22:59 INFO - PROCESS | 25649 | |2;jquery.html;386.4121630659329;389.2370952932252;391.46369473820863;394.3532606525299;413.21076743420076;17659.20533575989;17962.37131700391;18971.810281897193;19144.904275478602;19181.232750689975;18199.18103685334;18542.814571854313;18552.979586122758;19275.80724192761;19276;5501.9174712379345;5695.14572814077;5739.598228124033;5754.625949313302;5789.102689083199;5596.916046259289;5662.5753068520025;5701.57238207134;5715;5725.083986562151;5426.158945363475;5678.6024978251535;5695.316562012565;5741.454561816641;5746.827595172131;5797.971010144944;5805.477507024346;5822.097574875901;5823.213866128103;5850.824475265749;5569.192467092289;5816.82549523515;5824.941750582482;5857.355690874;5871.941280587225;13387.866121338759;13460.326983650877;13672.794908076286;14059.71880562383;14067.155970641692;2202.41635966469;2231.3975226688867;2234.7094877665963;2239.3282015395316;2273.8294627902974;9506.714798556055;9645.903540964571;9714.562844672007;10163.237757168243;10232.846507302396;1803.6302557975714;1907.1131923655566;1962.2249211561352;1971.4578490914969;2008.67861142218;53638.40402709166;80535;81049.18950810476;81152;81677.77483337813;8845.734627961043;9482.95258523703;9498;9819;10675.466226688635;12798.232106073665;12832.935835320764;12844.614661560168;12926.353682315847;12941.676458088436;7358.60186564551;7471.4396420268695;7595.878620716963;7598.962005189938;7912.367010639135;7964.163762804822;7978.920210797818;8000.51996880189;8095.7166499172245;8153.184681531918;3995.10110225197;3996.1408297215658;4008.378701301303;4029.3351596986167;4043.3934909763184;1902.1169042647955;1921;1926.8747531410693;1935.2839449403812;1972.2406873353862;888.9066648001867;917.8026724254318;953.6900507335143;1021.279997601689;1034.3380236648552;18568.350107746162;19020.809791902182;19035.428937131906;19265.325713599956;19422.80577194238;1013.3058854684565;1028.7428142964259;1029.6499190275342;1053.5417093564324;1062.6068354708652;10211.438370889524;10605.522751476048;10761.354318740901;10835.133189344833;10856.78286434267;509024;514285;514914;522703;539619;59903.70048149731;82026;94918;96670.51664741772;97201.51399242958;989.0455710239653;1002.0380434782691;1005.5022763732;1006.1045669354135;1022.3252653248969;16863.409780657617;16961;16966.23651935641;17186.91406542959;17196.570085747957;29985.85007075038;36061.27877442384;36120.4581931266;40319.59680403276;41534.79232603818;58629.4137058624;59502.70248648729;60396.39603604084;61902.19075901557;62106.136815895596;12226.816597751218;12941.741165176833;13052.673683157996;13064.21614703121;13260.469581217028;14303.356348964113;14516.98381113312;14556;14689.779653304995;14744.852551474349;12528.812067819172;12579.308138052495;12651.557195498113;12832.615021549369;12959.870401296244;12490.250584964931;12611;12633.3683315832;12686.11197216186;12913.031522635652;12812;12933.22400655926;12944.223346599234;13046.34768261602;13367.064305498521;12875.034372422293;12906.548270810477;12929.159604625669;12930.224186548838;13021.088523803242;12780.233186008869;12840.807387889003;12863.935680321538;12868.485260589847;12998.480060797841 05:22:59 INFO - PROCESS | 25649 | |3;mootools.html;1328.2163523521133;1495.3644701002074;1496.782966469862;1649.9752503712446;1797.4338083503703;8215.219554142355;8486.363522735805;8519.659213631456;8550.657973681045;8704.477731336108;8182.95908520458;8426.789330266747;8629.093945135748;8638.697645582406;8649.65401383944;2067.865588736727;2180.8255339572797;2243.1588154442084;2245.651923951786;2294.0135741631093;2219.0679914435977;2228.320362289501;2238.854474459163;2241.2491815241833;2245.5059886824874;2233.8883055847223;2291.873946932918;2292.988535057331;2294.197031039131;2298.689676893615;1967.8622496425255;2192.1012384922187;2246.528229071897;2254.075828910139;2265.6601509773664;2158.3956492182215;2160.0603737374295;2163.102312540294;2166.523364859728;2227.944301392462;8775.956120219422;8833.116688331116;8836.779080522974;8844.46933184011;8845.911540884574;5252.921206181911;5410.404855465896;5411.350637923435;5411.756470958816;5412.539934105605;3369.107186595554;3419.9316013679586;3438.6561343865665;3470.1151206442196;3538.7699799512948;1045.7803861189159;1061.3737894642197;1091.912646988247;1092.20814909191;1104.1718710966775;12114.939425302817;12417.006639468731;12429.564965226175;12430.627081187578;12431.316277604728;4520.683552151318;4620.584147426748;4730.526947305242;4733.95266047342;4778;10476.52855621499;10484.161267098614;10500.422476763699;10511.474426278808;10517.42154181512;4772.5227477252;5357.651752636066;5366.302380690485;5372.70450125239;5379.246905433242;4836.951630483721;4948.752562371867;4965.106280869406;4980.90038199234;5005.874853128628;3923.2349691810396;3946.644801967779;4058.6347228749555;4077.673786097105;4080.10237747695;1231.8829711177423;1236.313845815563;1249.6376050945123;1258.5720854909375;1267.043382246398;873.76845136039;972.3679608254691;977.4917043137528;996.3822430093388;1005.8843233028149;5865.237519122572;5905.793297234576;5947.910781338283;5988.9401105989255;6123;437.74829473052483;439.55165730954246;443.7914180335237;445.9620932220798;463.63836207758004;4183.644390226804;4315.395844581698;4318.3738357938555;4325.8269669213505;4430.180416622935;10527.631532896312;10925.672229833117;10995.120390368911;11008.834867476995;11036.779264414827;10843.132549396028;10914.126869850394;11009.944950275198;11230.10159187263;11295.774084518263;8394.286485648789;8419.326453883674;8467.703630372907;8498.065212826585;8522.78693032679;5776.162456443876;5780.913286300624;5817.127430885401;5891.469767720926;5966.463018328372;10020.148287395654;10463.790724185626;10497.47512624381;10517.05346518817;10593.629222977159;10592.146374384298;10627.89372106269;10735.516901739284;10821.891781082404;10873.293235939638;7044.295570442915;7587.165411804586;7861.842763144819;7880;8015.318697910743;8644.438111522732;8661.52361620117;8711.21599056088;8733.737987860375;8747.650093996423;7541.283578060075;7631.7328893490685;7679.155292917663;7686.884696729442;7996.520208787491;7749.070111586646;7799.688012479664;7803.765887023398;7943.602819859099;7949.960250198712;7209.6395180241825;7253.455990800817;7313.561186328838;7323.9267607323245;7326.413886889142;5310.734463276744;5329.440408757025;5418.593605479526;5476.58925580591;5588.273524441796;5493.176023596492;5511.944880551143;5546.278983732089;5616.157576363415;5761.135829625589 05:22:59 INFO - PROCESS | 25649 | |4;prototype.html;328.39739078790416;335.625777258357;337.51566502069534;342.26925514027573;343.594558421063;5344.786208551658;5345.7594408251625;5359.758810853511;5367.007103685821;5384.461553844613;5278.973605131979;5291.417944026154;5315.36215654121;5340.786368545254;5344.331958505187;3777.7544459610176;4008.3185858403995;4011.8997025074314;4090.4477895484174;4126.587341265879;4155.563665815092;4165.875023749292;4172.290710579209;4174.123434078847;4181.811818468176;4157.750534967911;4168.312228482297;4168.749875007509;4172.853950111747;4188.575884199372;4009.4587230724064;4022.275990321741;4122.134351786129;4167.749935003894;4201.327787553992;3629.9274014519824;3652.4886515887797;3653.7442379033478;3655.6527129922615;3665.4135338346005;5055.840099937539;5085.898282034339;5103.682606305893;5109.6678715883345;5154.278401023859;4680.180968330563;4680.602148817355;4690.413698287714;4713.175194341011;4714.811407543694;5448.536874365684;5460.726963651801;5463;5472.810875649772;5479.1781232815;3781.9810900945595;3921;3927.332353499883;3945.467361906163;3957.920841583181;5548.223248745179;5618.747156377973;5651.7739290428335;5693.601447898607;5720.3135623725;4117.238310912491;4137.46212992309;4140.888147045029;4150.439690641785;4154.605312495308;3928.4303775952326;4093.1813637272667;4109.116539943867;4111.794410279534;4200.7479551227025;4659.790309436084;4661.650376221797;4686.484486706459;4699.412573428322;4702.388689470347;5561.694106824082;5582;5598.804041858515;5602.915956260659;5611.691356975405;1375.6492094515834;1398.2030242761527;1411.1603595860447;1419.3754747910887;1422.11118051218;894.5329659358657;911.1753862754218;918.0223062438615;922.847730124522;924.6070420071443;4733.106757297109;4809.470958194595;4825.734584597811;4867.756612169377;4879.1461494238365;4963.6277279204205;4981.128302547112;4993.425756038029;5016.874578135503;5020.673656212334;4655.813767449332;4678.298255261738;4685.664585593089;4787.593054590329;4847.709137451764;2638.828476149044;2684.5436275833154;2700.189943017126;2732.7267273272514;2736.6715994080837;5074.82238121664;5126.53861152498;5139.203423469368;5201.661891977009;5279.788808447696;4825.9034819304115;5122.9743851281255;5137.33214682089;5154.845354639367;5181.3005244291535;5188.507091826271;5217.982493413824;5231.973840130851;5239.607029472729;5255.421903590602;5004.048421115695;5111.207762796773;5316.282301889196;5428.918566221589;5684.175794509691;5576.302962129734;5601.775928962796;5644.3508996465935;5649.378568357395;5664.85837854057;5673.8297851064535;5837.795677151279;5840.94159058404;5842.2405087338375;5871.091895134184;4012.137390461065;4015.1768887378603;4033.253848038122;4055.9797201013807;4056.1076563156057;5590.944090559043;5650.434956504481;5672.60291779588;5683.8863222736145;5716.5998380113;5269.920951185812;5489.890202196014;5518.841043380935;5518.944810551843;5557;5516.593268716451;5578;5593.580481463825;5594.552435805207;5604.159376093618;5502.449755024466;5503.284573005483;5509.641873278224;5511.366192887709;5519.254900588369;5347.5561598369;5543.113101903676;5547.195656629686;5590.580706447114;5632.464915832989;5413.918791218056;5453;5454.427285135003;5469.535089517435;5477.890442191054 05:22:59 INFO - PROCESS | 25649 | |5;yui.html;733.8972543843863;734.4344854462064;740.822202671359;785.1873311122989;790.3400660448525;14869.776953345709;15060.322285497152;15166.241687915615;15222.467213647524;15479.690406191869;14889.329980150893;15040.849591504082;15067.698646027073;15071.773923391158;15072.698546029073;670.3865962644174;774.543019618425;789.893364395805;806.5241507510567;807.422692774666;813.7599408174573;827.3257295304338;827.7061643116697;828.45736042892;828.5981299069946;848.6138806842872;853.0616322045731;854.0520022774715;856.3662889461816;858.2533196119385;697.7557854750847;826.7767702720292;841.8610929196675;855.2901092093548;856.220839036477;618.5113760129492;620.3362402229616;620.4818976154916;620.6989610039127;620.9441150296495;13588.660283492893;13600.183988960594;13617.114887532278;13639.318034098354;13742;13066.608001759962;13326;13629.727405451835;13667;13836.930815345859;11565.190436669436;12235.755284894341;12296.446659900237;12472.189307694971;12976;4542.295944128666;4559.430071241095;4575.611073058794;4634.050019745944;4764.0114328321115;64828.351716482706;65521.344786552;65639.3436065638;73675;78522.21477785206;11041.668749937515;11083.224174307883;11200.78720591601;11331.206815522999;11557.422128893522;20462.079206435745;20471.590568188552;20480.38558843237;20484.385468435972;20525.076371563315;8247.092819789817;8476.576171191417;8499.61751721174;8504.14958504157;8590.527520986281;4536.432945881765;4688.203005489075;4703.905921881612;4790.161721698759;4802.255650374198;3331.3670402623907;3422.144463884029;3426.2119712465774;3429.1427143214196;3434.4504879219703;543.8776275338097;545.7871430142247;550.4495504495504;552.2792755454171;562.2830890614499;555.3225065420181;563.6956043736418;649.447969226154;672.304165189027;762.7749813804941;9203.263738900872;9675.612975480903;9678.322517423854;9680.951595241979;9816.558254878548;645.6513482719279;657.050561937995;689.6103701408688;707.5012116457884;753.9434542409232;4414.668899832525;4647.488776234612;4769.14155452015;4806.663533552618;5024.296598476216;75082.6245868778;76490.23509764831;77320.61339693266;78993.60503197447;96527.51736241415;69295;76813.61593191998;83110.16889831024;97126;110233.44883275533;87909;88210;88485.05958749061;89694;94424.99999999863;9596;9608.471534065693;9676.9032309676;9683.194907246176;9717.611295548098;49827.75086124546;51913.7404312976;52556;52701.472985269655;54403.45596543984;61246.38753612407;61657.691711541156;63106.36893631005;77755.61122194579;84172.57913710392;12735.299558523999;12971.890933054403;13511.932440337736;13752.277773905567;13839.654008649864;13564.118332308368;14035.438582456587;15056.548303550911;15246.3901443941;15424.305906234022;14127.788083178555;14225.671831167449;14671.853281467049;14902.1803800792;15066.020708653903;14101.294935253401;14298.142111473346;14369.856301436852;14799.852001479847;14871.61554600868;13500.257485838372;13654.590362289147;13757.02825183711;13892.861071389561;14541.491047813275;11475.540978360772;11700.648980530597;11712;11727.472263748323;12012.579559715718;11102.111831053659;11105.444727763417;11368.602098926498;11420.086393088699;11757.706057348292 05:22:59 INFO - PROCESS | 25649 | __end_tp_report 05:22:59 INFO - PROCESS | 25649 | __start_cc_report 05:22:59 INFO - PROCESS | 25649 | _x_x_mozilla_cycle_collect,901 05:22:59 INFO - PROCESS | 25649 | __end_cc_report 05:22:59 INFO - PROCESS | 25649 | __startTimestamp1465561379072__endTimestamp 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | ------- Summary: start ------- 05:22:59 INFO - PROCESS | 25649 | Number of tests: 6 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#0] dojo.html Cycles:165 Average:5298.25 Median:5488.09 stddev:594.82 (10.8%) stddev-sans-first:570.40 05:22:59 INFO - PROCESS | 25649 | Values: 3071.0 3072.3 3091.2 3114.0 3123.2 5127.6 5177.7 5321.4 5401.8 5433.0 5234.2 5247.0 5298.9 5319.6 5331.7 4773.9 4783.9 4980.5 5028.2 5089.6 5000.2 5008.5 5011.3 5030.7 5040.3 4670.0 4704.3 4809.4 4814.9 4880.5 4881.5 4891.1 4892.8 4896.2 4938.2 4837.5 4859.6 4875.6 4890.7 4939.1 5188.3 5234.8 5264.4 5315.9 5371.1 5612.9 5653.0 5657.7 5660.1 5729.2 5749.6 5762.5 5776.1 5777.0 5779.5 5287.6 5350.4 5386.6 5402.7 5487.5 5964.0 5965.8 5976.3 5985.0 5986.4 5545.1 5749.8 5757.9 5759.4 5764.4 5615.3 5669.0 5669.1 5713.7 5717.4 5673.7 5680.4 5685.2 5685.9 5686.6 5514.6 5624.4 5692.7 5701.4 5702.1 4382.5 4384.6 4396.1 4425.8 4431.4 3878.6 3894.3 3912.8 3928.7 3948.6 5242.3 5306.4 5381.0 5407.3 5443.0 5650.4 5687.1 5708.8 5708.9 5756.3 5375.8 5378.2 5384.8 5391.2 5401.1 4729.3 4761.6 4786.1 4832.7 4865.2 5874.2 5895.6 5898.9 5900.1 5958.3 5696.9 5706.0 5706.0 5707.4 5708.7 5662.2 5684.6 5708.7 5747.1 5870.6 5483.3 5497.1 5504.8 5506.9 5526.4 5683.2 5705.5 5722.0 5737.4 5750.7 5441.6 5542.8 5560.2 5592.0 5641.0 5617.1 5619.8 5620.0 5622.4 5627.8 5358.3 5529.9 5536.9 5537.0 5543.5 5553.5 5572.8 5579.2 5665.8 5666.1 5452.8 5461.0 5465.0 5467.0 5488.1 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#1] ext.html Cycles:180 Average:58217.45 Median:42882.68 stddev:109213.56 (254.7%) stddev-sans-first:109434.28 05:22:59 INFO - PROCESS | 25649 | Values: 607.9 610.8 611.5 615.0 615.8 31275.5 42998.1 43962.8 44006.8 47920.5 45801.8 46101.0 46117.5 46141.8 46172.8 8851.9 8976.5 9007.1 9008.7 9042.4 8882.5 8975.0 8976.7 8979.7 8981.8 8956.2 8968.6 9011.3 9011.7 9015.7 8956.9 8979.3 9011.6 9024.5 9024.8 8853.7 8912.5 8927.5 8932.9 8944.2 42768.1 43007.4 43089.8 43110.0 43373.1 3674.0 3702.9 3726.1 3781.8 3826.8 32781.0 32921.3 33312.7 33438.8 34277.3 4211.5 4421.8 4470.4 4479.3 4564.5 377942.0 378488.0 378847.0 380319.1 380613.0 58817.4 59167.7 59269.0 59287.0 59293.7 62960.0 62973.4 63028.0 63112.0 63215.7 16709.8 16856.2 16895.0 16895.7 16916.7 13050.8 13092.3 13110.9 13118.3 13121.3 15052.8 16610.4 16844.3 16886.0 16918.3 5491.3 6366.5 6451.2 6569.9 6675.5 975.0 1013.6 1130.5 1159.2 1159.7 32153.7 32703.3 32783.2 32846.5 33193.5 1083.5 1105.8 1145.2 1163.2 1219.4 17179.7 17277.8 17368.4 17402.8 17458.6 511559.0 512287.0 517294.0 518382.0 519716.0 59845.0 59957.7 59976.0 60078.0 60118.4 1243.5 1337.5 1353.2 1361.8 1365.8 33012.5 34719.5 34760.5 34782.0 35299.8 50838.0 51300.5 51401.7 51490.5 51521.5 315583.0 320155.0 320823.0 322444.0 322712.0 40711.8 41798.8 42621.0 42853.0 42912.4 49660.0 50438.5 50481.0 51250.0 51806.2 41670.6 42283.4 42443.4 43347.6 43888.6 41552.0 41579.2 41916.4 42509.0 42796.6 41476.8 42636.8 43099.8 43326.8 43752.3 36605.6 37933.6 38544.8 38546.2 38809.6 28577.6 29181.4 29296.9 29381.9 29532.9 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#2] jquery.html Cycles:180 Average:29412.46 Median:1966.84 stddev:85468.14 (4345.5%) stddev-sans-first:85680.11 05:22:59 INFO - PROCESS | 25649 | Values: 386.4 389.2 391.5 394.4 413.2 17659.2 17962.4 18971.8 19144.9 19181.2 18199.2 18542.8 18553.0 19275.8 19276.0 5501.9 5695.1 5739.6 5754.6 5789.1 5596.9 5662.6 5701.6 5715.0 5725.1 5426.2 5678.6 5695.3 5741.5 5746.8 5798.0 5805.5 5822.1 5823.2 5850.8 5569.2 5816.8 5824.9 5857.4 5871.9 13387.9 13460.3 13672.8 14059.7 14067.2 2202.4 2231.4 2234.7 2239.3 2273.8 9506.7 9645.9 9714.6 10163.2 10232.8 1803.6 1907.1 1962.2 1971.5 2008.7 53638.4 80535.0 81049.2 81152.0 81677.8 8845.7 9483.0 9498.0 9819.0 10675.5 12798.2 12832.9 12844.6 12926.4 12941.7 7358.6 7471.4 7595.9 7599.0 7912.4 7964.2 7978.9 8000.5 8095.7 8153.2 3995.1 3996.1 4008.4 4029.3 4043.4 1902.1 1921.0 1926.9 1935.3 1972.2 888.9 917.8 953.7 1021.3 1034.3 18568.4 19020.8 19035.4 19265.3 19422.8 1013.3 1028.7 1029.6 1053.5 1062.6 10211.4 10605.5 10761.4 10835.1 10856.8 509024.0 514285.0 514914.0 522703.0 539619.0 59903.7 82026.0 94918.0 96670.5 97201.5 989.0 1002.0 1005.5 1006.1 1022.3 16863.4 16961.0 16966.2 17186.9 17196.6 29985.9 36061.3 36120.5 40319.6 41534.8 58629.4 59502.7 60396.4 61902.2 62106.1 12226.8 12941.7 13052.7 13064.2 13260.5 14303.4 14517.0 14556.0 14689.8 14744.9 12528.8 12579.3 12651.6 12832.6 12959.9 12490.3 12611.0 12633.4 12686.1 12913.0 12812.0 12933.2 12944.2 13046.3 13367.1 12875.0 12906.5 12929.2 12930.2 13021.1 12780.2 12840.8 12863.9 12868.5 12998.5 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#3] mootools.html Cycles:180 Average:5853.02 Median:4570.63 stddev:3378.20 (73.9%) stddev-sans-first:3370.56 05:22:59 INFO - PROCESS | 25649 | Values: 1328.2 1495.4 1496.8 1650.0 1797.4 8215.2 8486.4 8519.7 8550.7 8704.5 8183.0 8426.8 8629.1 8638.7 8649.7 2067.9 2180.8 2243.2 2245.7 2294.0 2219.1 2228.3 2238.9 2241.2 2245.5 2233.9 2291.9 2293.0 2294.2 2298.7 1967.9 2192.1 2246.5 2254.1 2265.7 2158.4 2160.1 2163.1 2166.5 2227.9 8776.0 8833.1 8836.8 8844.5 8845.9 5252.9 5410.4 5411.4 5411.8 5412.5 3369.1 3419.9 3438.7 3470.1 3538.8 1045.8 1061.4 1091.9 1092.2 1104.2 12114.9 12417.0 12429.6 12430.6 12431.3 4520.7 4620.6 4730.5 4734.0 4778.0 10476.5 10484.2 10500.4 10511.5 10517.4 4772.5 5357.7 5366.3 5372.7 5379.2 4837.0 4948.8 4965.1 4980.9 5005.9 3923.2 3946.6 4058.6 4077.7 4080.1 1231.9 1236.3 1249.6 1258.6 1267.0 873.8 972.4 977.5 996.4 1005.9 5865.2 5905.8 5947.9 5988.9 6123.0 437.7 439.6 443.8 446.0 463.6 4183.6 4315.4 4318.4 4325.8 4430.2 10527.6 10925.7 10995.1 11008.8 11036.8 10843.1 10914.1 11009.9 11230.1 11295.8 8394.3 8419.3 8467.7 8498.1 8522.8 5776.2 5780.9 5817.1 5891.5 5966.5 10020.1 10463.8 10497.5 10517.1 10593.6 10592.1 10627.9 10735.5 10821.9 10873.3 7044.3 7587.2 7861.8 7880.0 8015.3 8644.4 8661.5 8711.2 8733.7 8747.7 7541.3 7631.7 7679.2 7686.9 7996.5 7749.1 7799.7 7803.8 7943.6 7950.0 7209.6 7253.5 7313.6 7323.9 7326.4 5310.7 5329.4 5418.6 5476.6 5588.3 5493.2 5511.9 5546.3 5616.2 5761.1 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#4] prototype.html Cycles:180 Average:4540.65 Median:5106.68 stddev:1320.24 (25.9%) stddev-sans-first:1285.53 05:22:59 INFO - PROCESS | 25649 | Values: 328.4 335.6 337.5 342.3 343.6 5344.8 5345.8 5359.8 5367.0 5384.5 5279.0 5291.4 5315.4 5340.8 5344.3 3777.8 4008.3 4011.9 4090.4 4126.6 4155.6 4165.9 4172.3 4174.1 4181.8 4157.8 4168.3 4168.7 4172.9 4188.6 4009.5 4022.3 4122.1 4167.7 4201.3 3629.9 3652.5 3653.7 3655.7 3665.4 5055.8 5085.9 5103.7 5109.7 5154.3 4680.2 4680.6 4690.4 4713.2 4714.8 5448.5 5460.7 5463.0 5472.8 5479.2 3782.0 3921.0 3927.3 3945.5 3957.9 5548.2 5618.7 5651.8 5693.6 5720.3 4117.2 4137.5 4140.9 4150.4 4154.6 3928.4 4093.2 4109.1 4111.8 4200.7 4659.8 4661.7 4686.5 4699.4 4702.4 5561.7 5582.0 5598.8 5602.9 5611.7 1375.6 1398.2 1411.2 1419.4 1422.1 894.5 911.2 918.0 922.8 924.6 4733.1 4809.5 4825.7 4867.8 4879.1 4963.6 4981.1 4993.4 5016.9 5020.7 4655.8 4678.3 4685.7 4787.6 4847.7 2638.8 2684.5 2700.2 2732.7 2736.7 5074.8 5126.5 5139.2 5201.7 5279.8 4825.9 5123.0 5137.3 5154.8 5181.3 5188.5 5218.0 5232.0 5239.6 5255.4 5004.0 5111.2 5316.3 5428.9 5684.2 5576.3 5601.8 5644.4 5649.4 5664.9 5673.8 5837.8 5840.9 5842.2 5871.1 4012.1 4015.2 4033.3 4056.0 4056.1 5590.9 5650.4 5672.6 5683.9 5716.6 5269.9 5489.9 5518.8 5518.9 5557.0 5516.6 5578.0 5593.6 5594.6 5604.2 5502.4 5503.3 5509.6 5511.4 5519.3 5347.6 5543.1 5547.2 5590.6 5632.5 5413.9 5453.0 5454.4 5469.5 5477.9 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - PROCESS | 25649 | [#5] yui.html Cycles:180 Average:19349.77 Median:27426.02 stddev:26272.69 (95.8%) stddev-sans-first:26309.21 05:22:59 INFO - PROCESS | 25649 | Values: 733.9 734.4 740.8 785.2 790.3 14869.8 15060.3 15166.2 15222.5 15479.7 14889.3 15040.8 15067.7 15071.8 15072.7 670.4 774.5 789.9 806.5 807.4 813.8 827.3 827.7 828.5 828.6 848.6 853.1 854.1 856.4 858.3 697.8 826.8 841.9 855.3 856.2 618.5 620.3 620.5 620.7 620.9 13588.7 13600.2 13617.1 13639.3 13742.0 13066.6 13326.0 13629.7 13667.0 13836.9 11565.2 12235.8 12296.4 12472.2 12976.0 4542.3 4559.4 4575.6 4634.1 4764.0 64828.4 65521.3 65639.3 73675.0 78522.2 11041.7 11083.2 11200.8 11331.2 11557.4 20462.1 20471.6 20480.4 20484.4 20525.1 8247.1 8476.6 8499.6 8504.1 8590.5 4536.4 4688.2 4703.9 4790.2 4802.3 3331.4 3422.1 3426.2 3429.1 3434.5 543.9 545.8 550.4 552.3 562.3 555.3 563.7 649.4 672.3 762.8 9203.3 9675.6 9678.3 9681.0 9816.6 645.7 657.1 689.6 707.5 753.9 4414.7 4647.5 4769.1 4806.7 5024.3 75082.6 76490.2 77320.6 78993.6 96527.5 69295.0 76813.6 83110.2 97126.0 110233.4 87909.0 88210.0 88485.1 89694.0 94425.0 9596.0 9608.5 9676.9 9683.2 9717.6 49827.8 51913.7 52556.0 52701.5 54403.5 61246.4 61657.7 63106.4 77755.6 84172.6 12735.3 12971.9 13511.9 13752.3 13839.7 13564.1 14035.4 15056.5 15246.4 15424.3 14127.8 14225.7 14671.9 14902.2 15066.0 14101.3 14298.1 14369.9 14799.9 14871.6 13500.3 13654.6 13757.0 13892.9 14541.5 11475.5 11700.6 11712.0 11727.5 12012.6 11102.1 11105.4 11368.6 11420.1 11757.7 05:22:59 INFO - PROCESS | 25649 | -------- Summary: end -------- 05:22:59 INFO - PROCESS | 25649 | 05:22:59 INFO - TEST-INFO | 25649: exit 0 05:22:59 INFO - TEST-OK | dromaeo_css | took 1113559ms 05:22:59 INFO - TEST-START | kraken 05:22:59 INFO - operating with platform_type : linux_ 05:22:59 INFO - Initialising browser for kraken test... 05:22:59 INFO - TEST-INFO | started process 25830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5W5yH/profile http://localhost:58828/getInfo.html) 05:23:03 INFO - PROCESS | 25830 | __metrics Screen width/height:1600/1200 05:23:03 INFO - PROCESS | 25830 | colorDepth:24 05:23:03 INFO - PROCESS | 25830 | Browser inner width/height: 1024/697 05:23:03 INFO - PROCESS | 25830 | __metrics 05:23:04 ERROR - PROCESS | 25830 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:23:05 INFO - PROCESS | 25830 | console.error: PushService: 05:23:05 INFO - PROCESS | 25830 | stateChangeProcessEnqueue: Error transitioning state 05:23:05 INFO - PROCESS | 25830 | UnknownError 05:23:05 INFO - TEST-INFO | 25830: exit 0 05:23:05 INFO - Browser initialized. 05:23:05 INFO - Running cycle 1/1 for kraken test... 05:23:05 INFO - TEST-INFO | started process 25912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5W5yH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:17 INFO - PROCESS | 25912 | RSS: Main: 173588480 05:23:17 INFO - PROCESS | 25912 | 05:23:20 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:21 INFO - PROCESS | 25912 | RSS: Main: 231636992 05:23:21 INFO - PROCESS | 25912 | 05:23:24 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-dft) 05:23:24 INFO - PROCESS | 25912 | RSS: Main: 218816512 05:23:24 INFO - PROCESS | 25912 | 05:23:27 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-fft) 05:23:28 INFO - PROCESS | 25912 | RSS: Main: 285888512 05:23:28 INFO - PROCESS | 25912 | 05:23:30 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58828/tests/kraken/driver.html?testName=audio-oscillator) 05:23:31 INFO - PROCESS | 25912 | RSS: Main: 196452352 05:23:31 INFO - PROCESS | 25912 | 05:23:33 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:33 INFO - PROCESS | 25912 | RSS: Main: 199958528 05:23:33 INFO - PROCESS | 25912 | 05:23:36 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:37 INFO - PROCESS | 25912 | RSS: Main: 236445696 05:23:37 INFO - PROCESS | 25912 | 05:23:40 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58828/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:41 INFO - PROCESS | 25912 | RSS: Main: 237219840 05:23:41 INFO - PROCESS | 25912 | 05:23:44 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58828/tests/kraken/driver.html?testName=json-parse-financial) 05:23:44 INFO - PROCESS | 25912 | RSS: Main: 236781568 05:23:44 INFO - PROCESS | 25912 | 05:23:46 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:46 INFO - PROCESS | 25912 | RSS: Main: 220274688 05:23:46 INFO - PROCESS | 25912 | 05:23:48 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:49 INFO - PROCESS | 25912 | RSS: Main: 225153024 05:23:49 INFO - PROCESS | 25912 | 05:23:51 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:52 INFO - PROCESS | 25912 | RSS: Main: 234086400 05:23:52 INFO - PROCESS | 25912 | 05:23:54 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:55 INFO - PROCESS | 25912 | RSS: Main: 239792128 05:23:55 INFO - PROCESS | 25912 | 05:23:57 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:58 INFO - PROCESS | 25912 | RSS: Main: 239509504 05:23:58 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | Cycle 1(1): loaded http://localhost:58828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58828/tests/kraken/driver.html?testName=ai-astar) 05:24:00 INFO - PROCESS | 25912 | RSS: Main: 282800128 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | __start_tp_report 05:24:00 INFO - PROCESS | 25912 | _x_x_mozilla_page_load 05:24:00 INFO - PROCESS | 25912 | _x_x_mozilla_page_load_details 05:24:00 INFO - PROCESS | 25912 | |i|pagename|runs| 05:24:00 INFO - PROCESS | 25912 | |0;ai-astar;112;105;111;110;111;109;110;113;110;110 05:24:00 INFO - PROCESS | 25912 | |1;audio-beat-detection;163;129;127;173;142;127;158;126;171;132 05:24:00 INFO - PROCESS | 25912 | |2;audio-dft;160;162;162;162;162;163;161;163;161;161 05:24:00 INFO - PROCESS | 25912 | |3;audio-fft;73;75;76;121;76;76;74;76;104;75 05:24:00 INFO - PROCESS | 25912 | |4;audio-oscillator;85;84;108;86;87;86;122;84;85;125 05:24:00 INFO - PROCESS | 25912 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;117;117 05:24:00 INFO - PROCESS | 25912 | |6;imaging-darkroom;146;147;147;147;147;146;147;148;147;147 05:24:00 INFO - PROCESS | 25912 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 05:24:00 INFO - PROCESS | 25912 | |8;json-parse-financial;54;54;55;54;56;54;54;55;55;54 05:24:00 INFO - PROCESS | 25912 | |9;json-stringify-tinderbox;62;61;63;62;61;62;62;61;62;62 05:24:00 INFO - PROCESS | 25912 | |10;stanford-crypto-aes;80;80;79;79;83;79;82;81;114;81 05:24:00 INFO - PROCESS | 25912 | |11;stanford-crypto-ccm;120;121;132;119;120;120;118;126;127;131 05:24:00 INFO - PROCESS | 25912 | |12;stanford-crypto-pbkdf2;159;159;163;161;160;160;165;162;161;158 05:24:00 INFO - PROCESS | 25912 | |13;stanford-crypto-sha256-iterative;63;64;63;62;62;63;62;63;62;64 05:24:00 INFO - PROCESS | 25912 | __end_tp_report 05:24:00 INFO - PROCESS | 25912 | __start_cc_report 05:24:00 INFO - PROCESS | 25912 | _x_x_mozilla_cycle_collect,1644 05:24:00 INFO - PROCESS | 25912 | __end_cc_report 05:24:00 INFO - PROCESS | 25912 | __startTimestamp1465561440405__endTimestamp 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | ------- Summary: start ------- 05:24:00 INFO - PROCESS | 25912 | Number of tests: 14 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.13 (1.9%) stddev-sans-first:2.15 05:24:00 INFO - PROCESS | 25912 | Values: 112.0 105.0 111.0 110.0 111.0 109.0 110.0 113.0 110.0 110.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.00 stddev:19.42 (12.9%) stddev-sans-first:19.45 05:24:00 INFO - PROCESS | 25912 | Values: 163.0 129.0 127.0 173.0 142.0 127.0 158.0 126.0 171.0 132.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.78 05:24:00 INFO - PROCESS | 25912 | Values: 160.0 162.0 162.0 162.0 162.0 163.0 161.0 163.0 161.0 161.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:16.29 (21.6%) stddev-sans-first:16.90 05:24:00 INFO - PROCESS | 25912 | Values: 73.0 75.0 76.0 121.0 76.0 76.0 74.0 76.0 104.0 75.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.00 stddev:16.55 (19.5%) stddev-sans-first:17.14 05:24:00 INFO - PROCESS | 25912 | Values: 85.0 84.0 108.0 86.0 87.0 86.0 122.0 84.0 85.0 125.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:24:00 INFO - PROCESS | 25912 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:24:00 INFO - PROCESS | 25912 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:24:00 INFO - PROCESS | 25912 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 05:24:00 INFO - PROCESS | 25912 | Values: 54.0 54.0 55.0 54.0 56.0 54.0 54.0 55.0 55.0 54.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:24:00 INFO - PROCESS | 25912 | Values: 62.0 61.0 63.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:80.50 stddev:10.70 (13.3%) stddev-sans-first:11.26 05:24:00 INFO - PROCESS | 25912 | Values: 80.0 80.0 79.0 79.0 83.0 79.0 82.0 81.0 114.0 81.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.50 stddev:5.17 (4.2%) stddev-sans-first:5.33 05:24:00 INFO - PROCESS | 25912 | Values: 120.0 121.0 132.0 119.0 120.0 120.0 118.0 126.0 127.0 131.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.10 (1.3%) stddev-sans-first:2.12 05:24:00 INFO - PROCESS | 25912 | Values: 159.0 159.0 163.0 161.0 160.0 160.0 165.0 162.0 161.0 158.0 05:24:00 INFO - PROCESS | 25912 | 05:24:00 INFO - PROCESS | 25912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 05:24:00 INFO - PROCESS | 25912 | Values: 63.0 64.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 64.0 05:24:00 INFO - PROCESS | 25912 | -------- Summary: end -------- 05:24:00 INFO - PROCESS | 25912 | 05:24:01 INFO - TEST-INFO | 25912: exit 0 05:24:01 INFO - TEST-OK | kraken | took 61586ms 05:24:01 INFO - SUITE-END | took 1175s 05:24:01 INFO - Completed test suite (00:19:35) 05:24:01 INFO - javascript benchmark 05:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.984645076774, 3072.324088700486, 3091.1653853459575, 3113.9844300778523, 3123.203583086313, 5127.615428842842, 5177.715225662587, 5321.414644389114, 5401.783928642854, 5433.049216387131, 5234.241035049916, 5246.973765131169, 5298.894022119555, 5319.601029922752, 5331.733413329337, 4773.856784296477, 4783.928241076386, 4980.477049909761, 5028.170351891933, 5089.592832573404, 5000.19996800512, 5008.549230569248, 5011.32347133136, 5030.6981581105065, 5040.294358789773, 4670.042641258534, 4704.341392205077, 4809.374781278429, 4814.927776083362, 4880.487548807359, 4881.487443818419, 4891.0951473977075, 4892.828750993698, 4896.2410826321975, 4938.160512712848, 4837.516248375135, 4859.635527335428, 4875.609951203895, 4890.70655760652, 4939.061578300111, 5188.299579556749, 5234.8429547113265, 5264.368275806889, 5315.946840531623, 5371.086915224421, 5612.887742245132, 5653.0, 5657.717114144318, 5660.066089095294, 5729.226554415184, 5749.59752817303, 5762.452567006169, 5776.075827867563, 5777.046787280094, 5779.508741756956, 5287.603429742785, 5350.411454739976, 5386.569074474032, 5402.675839449606, 5487.451254874481, 5964.015937370285, 5965.791197308074, 5976.342602313742, 5985.0, 5986.401359864066, 5545.085060964976, 5749.798757043483, 5757.88484230313, 5759.424057594207, 5764.423557644286, 5615.326160860641, 5668.971655141698, 5669.092945128842, 5713.714314284269, 5717.42825717425, 5673.744681489343, 5680.375158732536, 5685.232493613309, 5685.857853553694, 5686.5735069869925, 5514.6139770216505, 5624.437556244425, 5692.686902220417, 5701.4013528579735, 5702.087665973508, 4382.517923028464, 4384.627306678968, 4396.076823867023, 4425.800838962255, 4431.357453169272, 3878.612138786099, 3894.299026175259, 3912.7847968361443, 3928.7249892507252, 3948.58539853317, 5242.344706911636, 5306.389765177054, 5381.031414345455, 5407.324084489439, 5443.047466693313, 5650.3502097258515, 5687.090065589486, 5708.828735137952, 5708.914366284509, 5756.30924289088, 5375.7849686012905, 5378.166384210375, 5384.811531596453, 5391.16436952273, 5401.054815407288, 4729.266963620645, 4761.595264402565, 4786.114568804782, 4832.661713680009, 4865.197242454955, 5874.206982057368, 5895.55783316253, 5898.852528686732, 5900.085486749561, 5958.255218097738, 5696.943030569641, 5705.971470142623, 5705.971470142623, 5707.429257074259, 5708.686022268815, 5662.207290979184, 5684.63049901755, 5708.686022268815, 5747.109198074305, 5870.589058765845, 5483.341998960151, 5497.147942068986, 5504.779808807763, 5506.862328441821, 5526.447355264441, 5683.204351390726, 5705.4579814917515, 5721.971390143189, 5737.397573254748, 5750.741216645178, 5441.619086663895, 5542.75057622416, 5560.165975103767, 5591.9720401397735, 5641.041023026013, 5617.073182924772, 5619.803306884403, 5619.971900140473, 5622.353429355513, 5627.803026894039, 5358.33020872391, 5529.944700552943, 5536.944630553643, 5537.031019571639, 5543.528800051879, 5553.527950124285, 5572.832815015556, 5579.19101730255, 5665.773369065191, 5666.093425052137, 5452.781888724407, 5461.0, 5464.972675136599, 5466.972665136649, 5488.094464413327], "value": 5258.582247191705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.911852781347, 610.8075956073836, 611.4955161991356, 615.031325662082, 615.7998650438609, 31275.530867036985, 42998.140037199235, 43962.7801860991, 44006.779966100126, 47920.52079479204, 45801.770991145, 46101.0, 46117.53882461174, 46141.7692911535, 46172.769136154355, 8851.91148088519, 8976.461412315282, 9007.054259302744, 9008.729738107868, 9042.367034307601, 8882.467051976902, 8974.955125224365, 8976.685815996441, 8979.685711000116, 8981.77545561363, 8956.19394254517, 8968.551572421386, 9011.27909767217, 9011.684591039315, 9015.729528114167, 8956.910430895672, 8979.326550508738, 9011.639534418615, 9024.503652299121, 9024.77438064047, 8853.73438796837, 8912.465252084896, 8927.464352138892, 8932.910670893338, 8944.23973962214, 42768.1446371074, 43007.35488967668, 43089.78455107704, 43110.0, 43373.13253734939, 3674.0447483654175, 3702.9444558331647, 3726.105734623698, 3781.810909454516, 3826.789526576037, 32781.02809164393, 32921.3415731684, 33312.666873331196, 33438.83280583606, 34277.31445371079, 4211.527694510637, 4421.778911054466, 4470.441194850644, 4479.283314669638, 4564.52072532386, 377942.0, 378488.0, 378847.0, 380319.09840450896, 380613.0, 58817.411825881194, 59167.70416147978, 59269.0, 59287.0, 59293.703531482926, 62960.0, 62973.42566435876, 63028.0, 63112.0, 63215.6839215801, 16709.83290167107, 16856.241469133918, 16895.0, 16895.662086758442, 16916.746248806277, 13050.804237936438, 13092.279924604238, 13110.934445327903, 13118.278494682883, 13121.278329691768, 15052.849471505364, 16610.418635347705, 16844.326226950783, 16886.0, 16918.323267069427, 5491.336701699673, 6366.490680745529, 6451.161349024691, 6569.934300657028, 6675.46596272297, 974.9561269742878, 1013.5945621751358, 1130.5364800431782, 1159.2406973432414, 1159.7042754097652, 32153.678463215536, 32703.345933081204, 32783.1804204892, 32846.507302390484, 33193.502097468554, 1083.5286650307141, 1105.7622611138643, 1145.169751929844, 1163.2322667039714, 1219.3781171602548, 17179.742303865452, 17277.840269966255, 17368.39210627622, 17402.825971740374, 17458.563535911704, 511559.0, 512287.0, 517294.0, 518382.0, 519716.0, 59845.0, 59957.70021149866, 59976.0, 60078.0, 60118.39881601128, 1243.521244320943, 1337.5452346202337, 1353.1678018018847, 1361.7889227169806, 1365.8429280632656, 33012.50481242831, 34719.47920781241, 34760.47859282164, 34782.045920704266, 35299.82350088336, 50838.0, 51300.48699512957, 51401.7429912848, 51490.48509515007, 51521.48478515167, 315583.0, 320155.0, 320823.0, 322444.0, 322712.0, 40711.79644101761, 41798.791006044776, 42621.0, 42853.0, 42912.35631465468, 49660.0, 50438.49561504338, 50481.0, 51250.0, 51806.222906655676, 41670.58329416788, 42283.3657495144, 42443.36334954917, 43347.566524334354, 43888.561114389726, 41552.0, 41579.16841663211, 41916.37125443182, 42509.0, 42796.572034279256, 41476.79261603673, 42636.78681606572, 43099.784501077294, 43326.78336608297, 43752.343714843664, 36605.60732712092, 37933.56826872632, 38544.82417038138, 38546.229075417774, 38809.6119038806, 28577.571336430385, 29181.41637167202, 29296.853515732284, 29381.85309073441, 29532.852335738186], "value": 20480.46985453842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.4121630659329, 389.2370952932252, 391.46369473820863, 394.3532606525299, 413.21076743420076, 17659.20533575989, 17962.37131700391, 18971.810281897193, 19144.904275478602, 19181.232750689975, 18199.18103685334, 18542.814571854313, 18552.979586122758, 19275.80724192761, 19276.0, 5501.9174712379345, 5695.14572814077, 5739.598228124033, 5754.625949313302, 5789.102689083199, 5596.916046259289, 5662.5753068520025, 5701.57238207134, 5715.0, 5725.083986562151, 5426.158945363475, 5678.6024978251535, 5695.316562012565, 5741.454561816641, 5746.827595172131, 5797.971010144944, 5805.477507024346, 5822.097574875901, 5823.213866128103, 5850.824475265749, 5569.192467092289, 5816.82549523515, 5824.941750582482, 5857.355690874, 5871.941280587225, 13387.866121338759, 13460.326983650877, 13672.794908076286, 14059.71880562383, 14067.155970641692, 2202.41635966469, 2231.3975226688867, 2234.7094877665963, 2239.3282015395316, 2273.8294627902974, 9506.714798556055, 9645.903540964571, 9714.562844672007, 10163.237757168243, 10232.846507302396, 1803.6302557975714, 1907.1131923655566, 1962.2249211561352, 1971.4578490914969, 2008.67861142218, 53638.40402709166, 80535.0, 81049.18950810476, 81152.0, 81677.77483337813, 8845.734627961043, 9482.95258523703, 9498.0, 9819.0, 10675.466226688635, 12798.232106073665, 12832.935835320764, 12844.614661560168, 12926.353682315847, 12941.676458088436, 7358.60186564551, 7471.4396420268695, 7595.878620716963, 7598.962005189938, 7912.367010639135, 7964.163762804822, 7978.920210797818, 8000.51996880189, 8095.7166499172245, 8153.184681531918, 3995.10110225197, 3996.1408297215658, 4008.378701301303, 4029.3351596986167, 4043.3934909763184, 1902.1169042647955, 1921.0, 1926.8747531410693, 1935.2839449403812, 1972.2406873353862, 888.9066648001867, 917.8026724254318, 953.6900507335143, 1021.279997601689, 1034.3380236648552, 18568.350107746162, 19020.809791902182, 19035.428937131906, 19265.325713599956, 19422.80577194238, 1013.3058854684565, 1028.7428142964259, 1029.6499190275342, 1053.5417093564324, 1062.6068354708652, 10211.438370889524, 10605.522751476048, 10761.354318740901, 10835.133189344833, 10856.78286434267, 509024.0, 514285.0, 514914.0, 522703.0, 539619.0, 59903.70048149731, 82026.0, 94918.0, 96670.51664741772, 97201.51399242958, 989.0455710239653, 1002.0380434782691, 1005.5022763732, 1006.1045669354135, 1022.3252653248969, 16863.409780657617, 16961.0, 16966.23651935641, 17186.91406542959, 17196.570085747957, 29985.85007075038, 36061.27877442384, 36120.4581931266, 40319.59680403276, 41534.79232603818, 58629.4137058624, 59502.70248648729, 60396.39603604084, 61902.19075901557, 62106.136815895596, 12226.816597751218, 12941.741165176833, 13052.673683157996, 13064.21614703121, 13260.469581217028, 14303.356348964113, 14516.98381113312, 14556.0, 14689.779653304995, 14744.852551474349, 12528.812067819172, 12579.308138052495, 12651.557195498113, 12832.615021549369, 12959.870401296244, 12490.250584964931, 12611.0, 12633.3683315832, 12686.11197216186, 12913.031522635652, 12812.0, 12933.22400655926, 12944.223346599234, 13046.34768261602, 13367.064305498521, 12875.034372422293, 12906.548270810477, 12929.159604625669, 12930.224186548838, 13021.088523803242, 12780.233186008869, 12840.807387889003, 12863.935680321538, 12868.485260589847, 12998.480060797841], "value": 9203.893716937499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.2163523521133, 1495.3644701002074, 1496.782966469862, 1649.9752503712446, 1797.4338083503703, 8215.219554142355, 8486.363522735805, 8519.659213631456, 8550.657973681045, 8704.477731336108, 8182.95908520458, 8426.789330266747, 8629.093945135748, 8638.697645582406, 8649.65401383944, 2067.865588736727, 2180.8255339572797, 2243.1588154442084, 2245.651923951786, 2294.0135741631093, 2219.0679914435977, 2228.320362289501, 2238.854474459163, 2241.2491815241833, 2245.5059886824874, 2233.8883055847223, 2291.873946932918, 2292.988535057331, 2294.197031039131, 2298.689676893615, 1967.8622496425255, 2192.1012384922187, 2246.528229071897, 2254.075828910139, 2265.6601509773664, 2158.3956492182215, 2160.0603737374295, 2163.102312540294, 2166.523364859728, 2227.944301392462, 8775.956120219422, 8833.116688331116, 8836.779080522974, 8844.46933184011, 8845.911540884574, 5252.921206181911, 5410.404855465896, 5411.350637923435, 5411.756470958816, 5412.539934105605, 3369.107186595554, 3419.9316013679586, 3438.6561343865665, 3470.1151206442196, 3538.7699799512948, 1045.7803861189159, 1061.3737894642197, 1091.912646988247, 1092.20814909191, 1104.1718710966775, 12114.939425302817, 12417.006639468731, 12429.564965226175, 12430.627081187578, 12431.316277604728, 4520.683552151318, 4620.584147426748, 4730.526947305242, 4733.95266047342, 4778.0, 10476.52855621499, 10484.161267098614, 10500.422476763699, 10511.474426278808, 10517.42154181512, 4772.5227477252, 5357.651752636066, 5366.302380690485, 5372.70450125239, 5379.246905433242, 4836.951630483721, 4948.752562371867, 4965.106280869406, 4980.90038199234, 5005.874853128628, 3923.2349691810396, 3946.644801967779, 4058.6347228749555, 4077.673786097105, 4080.10237747695, 1231.8829711177423, 1236.313845815563, 1249.6376050945123, 1258.5720854909375, 1267.043382246398, 873.76845136039, 972.3679608254691, 977.4917043137528, 996.3822430093388, 1005.8843233028149, 5865.237519122572, 5905.793297234576, 5947.910781338283, 5988.9401105989255, 6123.0, 437.74829473052483, 439.55165730954246, 443.7914180335237, 445.9620932220798, 463.63836207758004, 4183.644390226804, 4315.395844581698, 4318.3738357938555, 4325.8269669213505, 4430.180416622935, 10527.631532896312, 10925.672229833117, 10995.120390368911, 11008.834867476995, 11036.779264414827, 10843.132549396028, 10914.126869850394, 11009.944950275198, 11230.10159187263, 11295.774084518263, 8394.286485648789, 8419.326453883674, 8467.703630372907, 8498.065212826585, 8522.78693032679, 5776.162456443876, 5780.913286300624, 5817.127430885401, 5891.469767720926, 5966.463018328372, 10020.148287395654, 10463.790724185626, 10497.47512624381, 10517.05346518817, 10593.629222977159, 10592.146374384298, 10627.89372106269, 10735.516901739284, 10821.891781082404, 10873.293235939638, 7044.295570442915, 7587.165411804586, 7861.842763144819, 7880.0, 8015.318697910743, 8644.438111522732, 8661.52361620117, 8711.21599056088, 8733.737987860375, 8747.650093996423, 7541.283578060075, 7631.7328893490685, 7679.155292917663, 7686.884696729442, 7996.520208787491, 7749.070111586646, 7799.688012479664, 7803.765887023398, 7943.602819859099, 7949.960250198712, 7209.6395180241825, 7253.455990800817, 7313.561186328838, 7323.9267607323245, 7326.413886889142, 5310.734463276744, 5329.440408757025, 5418.593605479526, 5476.58925580591, 5588.273524441796, 5493.176023596492, 5511.944880551143, 5546.278983732089, 5616.157576363415, 5761.135829625589], "value": 4566.289065251247, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.39739078790416, 335.625777258357, 337.51566502069534, 342.26925514027573, 343.594558421063, 5344.786208551658, 5345.7594408251625, 5359.758810853511, 5367.007103685821, 5384.461553844613, 5278.973605131979, 5291.417944026154, 5315.36215654121, 5340.786368545254, 5344.331958505187, 3777.7544459610176, 4008.3185858403995, 4011.8997025074314, 4090.4477895484174, 4126.587341265879, 4155.563665815092, 4165.875023749292, 4172.290710579209, 4174.123434078847, 4181.811818468176, 4157.750534967911, 4168.312228482297, 4168.749875007509, 4172.853950111747, 4188.575884199372, 4009.4587230724064, 4022.275990321741, 4122.134351786129, 4167.749935003894, 4201.327787553992, 3629.9274014519824, 3652.4886515887797, 3653.7442379033478, 3655.6527129922615, 3665.4135338346005, 5055.840099937539, 5085.898282034339, 5103.682606305893, 5109.6678715883345, 5154.278401023859, 4680.180968330563, 4680.602148817355, 4690.413698287714, 4713.175194341011, 4714.811407543694, 5448.536874365684, 5460.726963651801, 5463.0, 5472.810875649772, 5479.1781232815, 3781.9810900945595, 3921.0, 3927.332353499883, 3945.467361906163, 3957.920841583181, 5548.223248745179, 5618.747156377973, 5651.7739290428335, 5693.601447898607, 5720.3135623725, 4117.238310912491, 4137.46212992309, 4140.888147045029, 4150.439690641785, 4154.605312495308, 3928.4303775952326, 4093.1813637272667, 4109.116539943867, 4111.794410279534, 4200.7479551227025, 4659.790309436084, 4661.650376221797, 4686.484486706459, 4699.412573428322, 4702.388689470347, 5561.694106824082, 5582.0, 5598.804041858515, 5602.915956260659, 5611.691356975405, 1375.6492094515834, 1398.2030242761527, 1411.1603595860447, 1419.3754747910887, 1422.11118051218, 894.5329659358657, 911.1753862754218, 918.0223062438615, 922.847730124522, 924.6070420071443, 4733.106757297109, 4809.470958194595, 4825.734584597811, 4867.756612169377, 4879.1461494238365, 4963.6277279204205, 4981.128302547112, 4993.425756038029, 5016.874578135503, 5020.673656212334, 4655.813767449332, 4678.298255261738, 4685.664585593089, 4787.593054590329, 4847.709137451764, 2638.828476149044, 2684.5436275833154, 2700.189943017126, 2732.7267273272514, 2736.6715994080837, 5074.82238121664, 5126.53861152498, 5139.203423469368, 5201.661891977009, 5279.788808447696, 4825.9034819304115, 5122.9743851281255, 5137.33214682089, 5154.845354639367, 5181.3005244291535, 5188.507091826271, 5217.982493413824, 5231.973840130851, 5239.607029472729, 5255.421903590602, 5004.048421115695, 5111.207762796773, 5316.282301889196, 5428.918566221589, 5684.175794509691, 5576.302962129734, 5601.775928962796, 5644.3508996465935, 5649.378568357395, 5664.85837854057, 5673.8297851064535, 5837.795677151279, 5840.94159058404, 5842.2405087338375, 5871.091895134184, 4012.137390461065, 4015.1768887378603, 4033.253848038122, 4055.9797201013807, 4056.1076563156057, 5590.944090559043, 5650.434956504481, 5672.60291779588, 5683.8863222736145, 5716.5998380113, 5269.920951185812, 5489.890202196014, 5518.841043380935, 5518.944810551843, 5557.0, 5516.593268716451, 5578.0, 5593.580481463825, 5594.552435805207, 5604.159376093618, 5502.449755024466, 5503.284573005483, 5509.641873278224, 5511.366192887709, 5519.254900588369, 5347.5561598369, 5543.113101903676, 5547.195656629686, 5590.580706447114, 5632.464915832989, 5413.918791218056, 5453.0, 5454.427285135003, 5469.535089517435, 5477.890442191054], "value": 4123.048301815544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8972543843863, 734.4344854462064, 740.822202671359, 785.1873311122989, 790.3400660448525, 14869.776953345709, 15060.322285497152, 15166.241687915615, 15222.467213647524, 15479.690406191869, 14889.329980150893, 15040.849591504082, 15067.698646027073, 15071.773923391158, 15072.698546029073, 670.3865962644174, 774.543019618425, 789.893364395805, 806.5241507510567, 807.422692774666, 813.7599408174573, 827.3257295304338, 827.7061643116697, 828.45736042892, 828.5981299069946, 848.6138806842872, 853.0616322045731, 854.0520022774715, 856.3662889461816, 858.2533196119385, 697.7557854750847, 826.7767702720292, 841.8610929196675, 855.2901092093548, 856.220839036477, 618.5113760129492, 620.3362402229616, 620.4818976154916, 620.6989610039127, 620.9441150296495, 13588.660283492893, 13600.183988960594, 13617.114887532278, 13639.318034098354, 13742.0, 13066.608001759962, 13326.0, 13629.727405451835, 13667.0, 13836.930815345859, 11565.190436669436, 12235.755284894341, 12296.446659900237, 12472.189307694971, 12976.0, 4542.295944128666, 4559.430071241095, 4575.611073058794, 4634.050019745944, 4764.0114328321115, 64828.351716482706, 65521.344786552, 65639.3436065638, 73675.0, 78522.21477785206, 11041.668749937515, 11083.224174307883, 11200.78720591601, 11331.206815522999, 11557.422128893522, 20462.079206435745, 20471.590568188552, 20480.38558843237, 20484.385468435972, 20525.076371563315, 8247.092819789817, 8476.576171191417, 8499.61751721174, 8504.14958504157, 8590.527520986281, 4536.432945881765, 4688.203005489075, 4703.905921881612, 4790.161721698759, 4802.255650374198, 3331.3670402623907, 3422.144463884029, 3426.2119712465774, 3429.1427143214196, 3434.4504879219703, 543.8776275338097, 545.7871430142247, 550.4495504495504, 552.2792755454171, 562.2830890614499, 555.3225065420181, 563.6956043736418, 649.447969226154, 672.304165189027, 762.7749813804941, 9203.263738900872, 9675.612975480903, 9678.322517423854, 9680.951595241979, 9816.558254878548, 645.6513482719279, 657.050561937995, 689.6103701408688, 707.5012116457884, 753.9434542409232, 4414.668899832525, 4647.488776234612, 4769.14155452015, 4806.663533552618, 5024.296598476216, 75082.6245868778, 76490.23509764831, 77320.61339693266, 78993.60503197447, 96527.51736241415, 69295.0, 76813.61593191998, 83110.16889831024, 97126.0, 110233.44883275533, 87909.0, 88210.0, 88485.05958749061, 89694.0, 94424.99999999863, 9596.0, 9608.471534065693, 9676.9032309676, 9683.194907246176, 9717.611295548098, 49827.75086124546, 51913.7404312976, 52556.0, 52701.472985269655, 54403.45596543984, 61246.38753612407, 61657.691711541156, 63106.36893631005, 77755.61122194579, 84172.57913710392, 12735.299558523999, 12971.890933054403, 13511.932440337736, 13752.277773905567, 13839.654008649864, 13564.118332308368, 14035.438582456587, 15056.548303550911, 15246.3901443941, 15424.305906234022, 14127.788083178555, 14225.671831167449, 14671.853281467049, 14902.1803800792, 15066.020708653903, 14101.294935253401, 14298.142111473346, 14369.856301436852, 14799.852001479847, 14871.61554600868, 13500.257485838372, 13654.590362289147, 13757.02825183711, 13892.861071389561, 14541.491047813275, 11475.540978360772, 11700.648980530597, 11712.0, 11727.472263748323, 12012.579559715718, 11102.111831053659, 11105.444727763417, 11368.602098926498, 11420.086393088699, 11757.706057348292], "value": 7409.8660024246865, "unit": "score"}], "name": "dromaeo_css", "value": 7191.232620630826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 109.0, 110.0, 113.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 127.0, 173.0, 142.0, 127.0, 158.0, 126.0, 171.0, 132.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 121.0, 76.0, 76.0, 74.0, 76.0, 104.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 108.0, 86.0, 87.0, 86.0, 122.0, 84.0, 85.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 83.0, 79.0, 82.0, 81.0, 114.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 132.0, 119.0, 120.0, 120.0, 118.0, 126.0, 127.0, 131.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 163.0, 161.0, 160.0, 160.0, 165.0, 162.0, 161.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1499.9, "alertThreshold": 2.0}]} 05:24:01 INFO - Return code: 0 05:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:01 ERROR - # TBPL SUCCESS # 05:24:01 INFO - Running post-action listener: _resource_record_post_action 05:24:01 INFO - ##### 05:24:01 INFO - ##### Finished run-tests step (success) 05:24:01 INFO - ##### 05:24:01 INFO - Running post-run listener: _resource_record_post_run 05:24:01 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 540835840; Read time: 24; Write time: 501484 05:24:01 INFO - TinderboxPrint: CPU usage
13.3% 05:24:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 05:24:01 INFO - TinderboxPrint: I/O write bytes / time
540,835,840 / 501,484 05:24:01 INFO - TinderboxPrint: CPU idle
8,256.7 (86.7%) 05:24:01 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 05:24:01 INFO - TinderboxPrint: Swap in / out
0 / 0 05:24:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248111104; Read time: 0; Write time: 339240 05:24:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292724736; Read time: 24; Write time: 162244 05:24:02 INFO - Running post-run listener: _upload_blobber_files 05:24:02 INFO - Blob upload gear active. 05:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:02 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 05:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:03 INFO - (blobuploader) - INFO - Done attempting. 05:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:04 INFO - (blobuploader) - INFO - Done attempting. 05:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:08 INFO - (blobuploader) - INFO - Done attempting. 05:24:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:08 INFO - Return code: 0 05:24:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/388d2c3dc9a08ca2916d64545af0b7e8e5dc4cb4d5e20d5b875ebc6418a5a1d5bdba140d18e7a7c5310a30f2f6ae920d459b06dab2e0a04bd6576ee410c8edd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d3a0a70fae17c01577e90afedcedbd74469788bbae6e99fb7fedf54335bebe2e21be5c4f7dfc7186d1a620a93c818bbef4fd3d845bd40845942c7b752f90d6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00ab972b623e21735fd9352ed27ebff343e7ad59c0903d5f6b5377ed950128339a7e60df22523bf978740a1fb4e96116574ab914658158a9b519a5b624e94d2d"} 05:24:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:08 INFO - Contents: 05:24:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/388d2c3dc9a08ca2916d64545af0b7e8e5dc4cb4d5e20d5b875ebc6418a5a1d5bdba140d18e7a7c5310a30f2f6ae920d459b06dab2e0a04bd6576ee410c8edd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d3a0a70fae17c01577e90afedcedbd74469788bbae6e99fb7fedf54335bebe2e21be5c4f7dfc7186d1a620a93c818bbef4fd3d845bd40845942c7b752f90d6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00ab972b623e21735fd9352ed27ebff343e7ad59c0903d5f6b5377ed950128339a7e60df22523bf978740a1fb4e96116574ab914658158a9b519a5b624e94d2d"} 05:24:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:08 INFO - Copying logs to upload dir... 05:24:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.656797 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-10 05:24:08.323449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:08.326971) ========= 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-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/388d2c3dc9a08ca2916d64545af0b7e8e5dc4cb4d5e20d5b875ebc6418a5a1d5bdba140d18e7a7c5310a30f2f6ae920d459b06dab2e0a04bd6576ee410c8edd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d3a0a70fae17c01577e90afedcedbd74469788bbae6e99fb7fedf54335bebe2e21be5c4f7dfc7186d1a620a93c818bbef4fd3d845bd40845942c7b752f90d6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00ab972b623e21735fd9352ed27ebff343e7ad59c0903d5f6b5377ed950128339a7e60df22523bf978740a1fb4e96116574ab914658158a9b519a5b624e94d2d"} build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/388d2c3dc9a08ca2916d64545af0b7e8e5dc4cb4d5e20d5b875ebc6418a5a1d5bdba140d18e7a7c5310a30f2f6ae920d459b06dab2e0a04bd6576ee410c8edd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d3a0a70fae17c01577e90afedcedbd74469788bbae6e99fb7fedf54335bebe2e21be5c4f7dfc7186d1a620a93c818bbef4fd3d845bd40845942c7b752f90d6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00ab972b623e21735fd9352ed27ebff343e7ad59c0903d5f6b5377ed950128339a7e60df22523bf978740a1fb4e96116574ab914658158a9b519a5b624e94d2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:08.354275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:08.354767) ========= 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-1465559889.698925-716717929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:24:08.441249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:24:08.442067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:24:08.442644) ========= ========= Total master_lag: 0.19 =========