builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1466683998.75 results: success (0) buildid: 20160623023010 builduid: 11aba33b88fd4657b74f814f1a519b77 revision: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.750188) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.751186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.751554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.767703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.768070) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 05:13:18-- 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% 46.0M=0s 2016-06-23 05:13:18 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.882315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.882701) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015687 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.933718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:18.934131) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 --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 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 --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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 05:13:19,082 truncating revision to first 12 chars 2016-06-23 05:13:19,082 Setting DEBUG logging. 2016-06-23 05:13:19,083 attempt 1/10 2016-06-23 05:13:19,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f29b11f5ae8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 05:13:19,430 unpacking tar archive at: fx-team-5f29b11f5ae8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:19.639257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:19.639642) ========= script_repo_revision: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:19.640133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:19.640473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 05:13:19.651218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-23 05:13:19.651679) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:13:19 INFO - MultiFileLogger online at 20160623 05:13:19 in /builds/slave/test 05:13:19 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:13:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:19 INFO - {'append_to_log': False, 05:13:19 INFO - 'base_work_dir': '/builds/slave/test', 05:13:19 INFO - 'blob_upload_branch': 'Fx-Team', 05:13:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:19 INFO - 'branch': 'Fx-Team', 05:13:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:19 INFO - 'config_files': ('talos/linux_config.py',), 05:13:19 INFO - 'default_actions': ('clobber', 05:13:19 INFO - 'read-buildbot-config', 05:13:19 INFO - 'download-and-extract', 05:13:19 INFO - 'populate-webroot', 05:13:19 INFO - 'create-virtualenv', 05:13:19 INFO - 'install', 05:13:19 INFO - 'run-tests'), 05:13:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:19 INFO - 'download_minidump_stackwalk': True, 05:13:19 INFO - 'download_symbols': 'ondemand', 05:13:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:19 INFO - 'installer_path': 'installer.exe', 05:13:19 INFO - 'log_level': 'info', 05:13:19 INFO - 'log_name': 'talos', 05:13:19 INFO - 'log_to_console': True, 05:13:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:13:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:13:19 INFO - 'opt_config_files': (), 05:13:19 INFO - 'pip_index': False, 05:13:19 INFO - 'sps_profile': False, 05:13:19 INFO - 'sps_profile_interval': 0, 05:13:19 INFO - 'suite': 'dromaeojs', 05:13:19 INFO - 'system_bits': '32', 05:13:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:19 INFO - 'title': 'talos-linux64-ix-034', 05:13:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:19 INFO - 'use_talos_json': True, 05:13:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:19 INFO - 'work_dir': 'build'} 05:13:19 INFO - ##### 05:13:19 INFO - ##### Running clobber step. 05:13:19 INFO - ##### 05:13:19 INFO - Running pre-action listener: _resource_record_pre_action 05:13:19 INFO - Running main action method: clobber 05:13:19 INFO - rmtree: /builds/slave/test/build 05:13:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:20 INFO - Running post-action listener: _resource_record_post_action 05:13:20 INFO - ##### 05:13:20 INFO - ##### Finished clobber step (success) 05:13:20 INFO - ##### 05:13:20 INFO - ##### 05:13:20 INFO - ##### Running read-buildbot-config step. 05:13:20 INFO - ##### 05:13:20 INFO - Running pre-action listener: _resource_record_pre_action 05:13:20 INFO - Running main action method: read_buildbot_config 05:13:20 INFO - Using buildbot properties: 05:13:20 INFO - { 05:13:20 INFO - "project": "", 05:13:20 INFO - "product": "firefox", 05:13:20 INFO - "script_repo_revision": "production", 05:13:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:13:20 INFO - "repository": "", 05:13:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:13:20 INFO - "buildid": "20160623023010", 05:13:20 INFO - "pgo_build": "True", 05:13:20 INFO - "basedir": "/builds/slave/test", 05:13:20 INFO - "buildnumber": 821, 05:13:20 INFO - "slavename": "talos-linux64-ix-034", 05:13:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:13:20 INFO - "platform": "ubuntu64_hw", 05:13:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:13:20 INFO - "branch": "fx-team", 05:13:20 INFO - "repo_path": "integration/fx-team", 05:13:20 INFO - "revision": "5f29b11f5ae8ce218baf26ad8e19340f6ee35b70", 05:13:20 INFO - "stage_platform": "linux64-pgo", 05:13:20 INFO - "builduid": "11aba33b88fd4657b74f814f1a519b77", 05:13:20 INFO - "slavebuilddir": "test" 05:13:20 INFO - } 05:13:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:13:20 INFO - Running post-action listener: _resource_record_post_action 05:13:20 INFO - ##### 05:13:20 INFO - ##### Finished read-buildbot-config step (success) 05:13:20 INFO - ##### 05:13:20 INFO - ##### 05:13:20 INFO - ##### Running download-and-extract step. 05:13:20 INFO - ##### 05:13:20 INFO - Running pre-action listener: _resource_record_pre_action 05:13:20 INFO - Running main action method: download_and_extract 05:13:20 INFO - mkdir: /builds/slave/test/build/tests 05:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:20 INFO - https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:21 INFO - Downloaded 1361 bytes. 05:13:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:13:21 INFO - Using the following test package requirements: 05:13:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:13:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:13:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'jsshell-linux-x86_64.zip'], 05:13:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:13:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:13:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:13:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:13:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:13:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:23 INFO - Downloaded 24276007 bytes. 05:13:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:13:24 INFO - Return code: 0 05:13:24 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:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:24 INFO - https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:25 INFO - Downloaded 24276007 bytes. 05:13:25 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:13:25 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:13:27 INFO - Return code: 0 05:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:27 INFO - https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:28 INFO - Downloaded 14405384 bytes. 05:13:28 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:13:28 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:13:28 INFO - Return code: 0 05:13: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:13:28 INFO - https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S20JVAvUThyqsLTa1DDPmQ/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:13:29 INFO - Downloaded 60166608 bytes. 05:13:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:29 INFO - mkdir: /builds/slave/test/properties 05:13:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:29 INFO - Contents: 05:13:29 INFO - build_url:https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:30 INFO - Running post-action listener: _resource_record_post_action 05:13:30 INFO - Running post-action listener: set_extra_try_arguments 05:13:30 INFO - ##### 05:13:30 INFO - ##### Finished download-and-extract step (success) 05:13:30 INFO - ##### 05:13:30 INFO - ##### 05:13:30 INFO - ##### Running populate-webroot step. 05:13:30 INFO - ##### 05:13:30 INFO - Running pre-action listener: _resource_record_pre_action 05:13:30 INFO - Running main action method: populate_webroot 05:13:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:30 INFO - '--tppagecycles', 05:13:30 INFO - '7'], 05:13:30 INFO - 'tests': ['tsvgm']}}, 05:13:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:13:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:13:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['damp', 'tps']}, 05:13:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'tests': ['damp', 'tps']}, 05:13:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['dromaeo_dom']}, 05:13:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['basic_compositor_video']}, 05:13:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:13:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tsvgx', 05:13:30 INFO - 'tsvgr_opacity', 05:13:30 INFO - 'tart', 05:13:30 INFO - 'tscrollx', 05:13:30 INFO - 'cart']}, 05:13:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:13:30 INFO - 'tsvgr_opacity', 05:13:30 INFO - 'tart', 05:13:30 INFO - 'tscrollx', 05:13:30 INFO - 'cart']}, 05:13:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tp5o']}, 05:13:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'tests': ['tp5o']}, 05:13:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s', 05:13:30 INFO - '--xperf_path', 05:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:30 INFO - 'tests': ['tp5n']}, 05:13:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:30 INFO - 'talos_options': ['--xperf_path', 05:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:30 INFO - 'tests': ['tp5n']}}, 05:13:30 INFO - 'talos.zip': {'path': '', 05:13:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:30 INFO - Running post-action listener: _resource_record_post_action 05:13:30 INFO - ##### 05:13:30 INFO - ##### Finished populate-webroot step (success) 05:13:30 INFO - ##### 05:13:30 INFO - ##### 05:13:30 INFO - ##### Running create-virtualenv step. 05:13:30 INFO - ##### 05:13:30 INFO - Running pre-action listener: _resource_record_pre_action 05:13:30 INFO - Running main action method: create_virtualenv 05:13:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:30 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:13:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:30 INFO - Using real prefix '/usr' 05:13:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:33 INFO - Installing pip.................done. 05:13:33 INFO - Return code: 0 05:13:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:13:33 INFO - Using env: {'DISPLAY': ':0', 05:13:33 INFO - 'HOME': '/home/cltbld', 05:13:33 INFO - 'LANG': 'en_US.UTF-8', 05:13:33 INFO - 'LANGUAGE': 'en_US:en', 05:13:33 INFO - 'LOGNAME': 'cltbld', 05:13:33 INFO - 'MAIL': '/var/mail/cltbld', 05:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:33 INFO - 'MOZ_NO_REMOTE': '1', 05:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:33 INFO - 'NO_EM_RESTART': '1', 05:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:33 INFO - 'PWD': '/builds/slave/test', 05:13:33 INFO - 'SHELL': '/bin/bash', 05:13:33 INFO - 'SHLVL': '1', 05:13:33 INFO - 'TERM': 'linux', 05:13:33 INFO - 'TMOUT': '86400', 05:13:33 INFO - 'USER': 'cltbld', 05:13:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:33 INFO - '_': '/tools/buildbot/bin/python'} 05:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:13:33 INFO - Cleaning up... 05:13:33 INFO - Return code: 0 05:13:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:13:33 INFO - Using env: {'DISPLAY': ':0', 05:13:33 INFO - 'HOME': '/home/cltbld', 05:13:33 INFO - 'LANG': 'en_US.UTF-8', 05:13:33 INFO - 'LANGUAGE': 'en_US:en', 05:13:33 INFO - 'LOGNAME': 'cltbld', 05:13:33 INFO - 'MAIL': '/var/mail/cltbld', 05:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:33 INFO - 'MOZ_NO_REMOTE': '1', 05:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:33 INFO - 'NO_EM_RESTART': '1', 05:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:33 INFO - 'PWD': '/builds/slave/test', 05:13:33 INFO - 'SHELL': '/bin/bash', 05:13:33 INFO - 'SHLVL': '1', 05:13:33 INFO - 'TERM': 'linux', 05:13:33 INFO - 'TMOUT': '86400', 05:13:33 INFO - 'USER': 'cltbld', 05:13:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:33 INFO - '_': '/tools/buildbot/bin/python'} 05:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:33 INFO - Downloading/unpacking psutil>=3.1.1 05:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:35 INFO - Installing collected packages: psutil 05:13:35 INFO - Running setup.py install for psutil 05:13:35 INFO - building 'psutil._psutil_linux' extension 05:13:35 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:13:35 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:13:35 INFO - building 'psutil._psutil_posix' extension 05:13:35 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:13:35 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:13:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:36 INFO - Successfully installed psutil 05:13:36 INFO - Cleaning up... 05:13:36 INFO - Return code: 0 05:13:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:13:36 INFO - Using env: {'DISPLAY': ':0', 05:13:36 INFO - 'HOME': '/home/cltbld', 05:13:36 INFO - 'LANG': 'en_US.UTF-8', 05:13:36 INFO - 'LANGUAGE': 'en_US:en', 05:13:36 INFO - 'LOGNAME': 'cltbld', 05:13:36 INFO - 'MAIL': '/var/mail/cltbld', 05:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:36 INFO - 'MOZ_NO_REMOTE': '1', 05:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:36 INFO - 'NO_EM_RESTART': '1', 05:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:36 INFO - 'PWD': '/builds/slave/test', 05:13:36 INFO - 'SHELL': '/bin/bash', 05:13:36 INFO - 'SHLVL': '1', 05:13:36 INFO - 'TERM': 'linux', 05:13:36 INFO - 'TMOUT': '86400', 05:13:36 INFO - 'USER': 'cltbld', 05:13:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:36 INFO - '_': '/tools/buildbot/bin/python'} 05:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:13:38 INFO - Installing collected packages: mozsystemmonitor 05:13:38 INFO - Running setup.py install for mozsystemmonitor 05:13:38 INFO - Successfully installed mozsystemmonitor 05:13:38 INFO - Cleaning up... 05:13:38 INFO - Return code: 0 05:13:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:13:38 INFO - Using env: {'DISPLAY': ':0', 05:13:38 INFO - 'HOME': '/home/cltbld', 05:13:38 INFO - 'LANG': 'en_US.UTF-8', 05:13:38 INFO - 'LANGUAGE': 'en_US:en', 05:13:38 INFO - 'LOGNAME': 'cltbld', 05:13:38 INFO - 'MAIL': '/var/mail/cltbld', 05:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:38 INFO - 'MOZ_NO_REMOTE': '1', 05:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:38 INFO - 'NO_EM_RESTART': '1', 05:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:38 INFO - 'PWD': '/builds/slave/test', 05:13:38 INFO - 'SHELL': '/bin/bash', 05:13:38 INFO - 'SHLVL': '1', 05:13:38 INFO - 'TERM': 'linux', 05:13:38 INFO - 'TMOUT': '86400', 05:13:38 INFO - 'USER': 'cltbld', 05:13:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:38 INFO - '_': '/tools/buildbot/bin/python'} 05:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:13:38 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:13:38 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:13:38 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:13:38 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:13:38 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:13:38 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:13:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:40 INFO - warning: no files found matching '*.txt' 05:13:40 INFO - no previously-included directories found matching 'build' 05:13:40 INFO - no previously-included directories found matching 'dist' 05:13:40 INFO - no previously-included directories found matching '.git*' 05:13:40 INFO - Installing collected packages: jsonschema, functools32 05:13:40 INFO - Running setup.py install for functools32 05:13:40 INFO - warning: no files found matching '*.txt' 05:13:40 INFO - no previously-included directories found matching 'build' 05:13:40 INFO - no previously-included directories found matching 'dist' 05:13:40 INFO - no previously-included directories found matching '.git*' 05:13:40 INFO - Successfully installed jsonschema functools32 05:13:40 INFO - Cleaning up... 05:13:41 INFO - Return code: 0 05:13:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13: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:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:13:41 INFO - Using env: {'DISPLAY': ':0', 05:13:41 INFO - 'HOME': '/home/cltbld', 05:13:41 INFO - 'LANG': 'en_US.UTF-8', 05:13:41 INFO - 'LANGUAGE': 'en_US:en', 05:13:41 INFO - 'LOGNAME': 'cltbld', 05:13:41 INFO - 'MAIL': '/var/mail/cltbld', 05:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:41 INFO - 'MOZ_NO_REMOTE': '1', 05:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:41 INFO - 'NO_EM_RESTART': '1', 05:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:41 INFO - 'PWD': '/builds/slave/test', 05:13:41 INFO - 'SHELL': '/bin/bash', 05:13:41 INFO - 'SHLVL': '1', 05:13:41 INFO - 'TERM': 'linux', 05:13:41 INFO - 'TMOUT': '86400', 05:13:41 INFO - 'USER': 'cltbld', 05:13:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:41 INFO - '_': '/tools/buildbot/bin/python'} 05:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - Downloading docopt-0.6.1.tar.gz 05:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:43 INFO - Running setup.py install for blobuploader 05:13:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:43 INFO - Running setup.py install for requests 05:13:44 INFO - Running setup.py install for docopt 05:13:44 INFO - Successfully installed blobuploader requests docopt 05:13:44 INFO - Cleaning up... 05:13:44 INFO - Return code: 0 05:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:13:44 INFO - Using env: {'DISPLAY': ':0', 05:13:44 INFO - 'HOME': '/home/cltbld', 05:13:44 INFO - 'LANG': 'en_US.UTF-8', 05:13:44 INFO - 'LANGUAGE': 'en_US:en', 05:13:44 INFO - 'LOGNAME': 'cltbld', 05:13:44 INFO - 'MAIL': '/var/mail/cltbld', 05:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:44 INFO - 'MOZ_NO_REMOTE': '1', 05:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:44 INFO - 'NO_EM_RESTART': '1', 05:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:44 INFO - 'PWD': '/builds/slave/test', 05:13:44 INFO - 'SHELL': '/bin/bash', 05:13:44 INFO - 'SHLVL': '1', 05:13:44 INFO - 'TERM': 'linux', 05:13:44 INFO - 'TMOUT': '86400', 05:13:44 INFO - 'USER': 'cltbld', 05:13:44 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:44 INFO - '_': '/tools/buildbot/bin/python'} 05:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:44 INFO - Running setup.py (path:/tmp/pip-9i7cj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:44 INFO - Running setup.py (path:/tmp/pip-TKMBY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:44 INFO - Running setup.py (path:/tmp/pip-Pj1nwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:44 INFO - Running setup.py (path:/tmp/pip-cxuBJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:45 INFO - Running setup.py (path:/tmp/pip-937Gf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:45 INFO - Running setup.py (path:/tmp/pip-bEMn4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:45 INFO - Running setup.py (path:/tmp/pip-r2_S1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:45 INFO - Running setup.py (path:/tmp/pip-sXRdTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:45 INFO - Running setup.py (path:/tmp/pip-qKJqgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:45 INFO - Running setup.py (path:/tmp/pip-5NOM5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:45 INFO - Running setup.py (path:/tmp/pip-e9imtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:45 INFO - Running setup.py (path:/tmp/pip-pM6qHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:45 INFO - Running setup.py (path:/tmp/pip-Tc3N4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:45 INFO - Running setup.py (path:/tmp/pip-brFnTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:45 INFO - Running setup.py (path:/tmp/pip-VclrY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:45 INFO - Running setup.py (path:/tmp/pip-KD12Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:45 INFO - Running setup.py (path:/tmp/pip-V4TRMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:45 INFO - Running setup.py install for manifestparser 05:13:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for mozcrash 05:13:46 INFO - Running setup.py install for mozdebug 05:13:46 INFO - Running setup.py install for mozdevice 05:13:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for mozfile 05:13:46 INFO - Running setup.py install for mozhttpd 05:13:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for mozinfo 05:13:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for mozInstall 05:13:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for mozleak 05:13:46 INFO - Running setup.py install for mozlog 05:13:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:46 INFO - Running setup.py install for moznetwork 05:13:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Running setup.py install for mozprocess 05:13:47 INFO - Running setup.py install for mozprofile 05:13:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Running setup.py install for mozrunner 05:13:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Running setup.py install for mozscreenshot 05:13:47 INFO - Running setup.py install for moztest 05:13:47 INFO - Running setup.py install for mozversion 05:13:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:47 INFO - Cleaning up... 05:13:47 INFO - Return code: 0 05:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:47 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:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:47 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:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:47 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 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:47 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:13:47 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:13:47 INFO - Using env: {'DISPLAY': ':0', 05:13:47 INFO - 'HOME': '/home/cltbld', 05:13:47 INFO - 'LANG': 'en_US.UTF-8', 05:13:47 INFO - 'LANGUAGE': 'en_US:en', 05:13:47 INFO - 'LOGNAME': 'cltbld', 05:13:47 INFO - 'MAIL': '/var/mail/cltbld', 05:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:47 INFO - 'MOZ_NO_REMOTE': '1', 05:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:47 INFO - 'NO_EM_RESTART': '1', 05:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:47 INFO - 'PWD': '/builds/slave/test', 05:13:47 INFO - 'SHELL': '/bin/bash', 05:13:47 INFO - 'SHLVL': '1', 05:13:47 INFO - 'TERM': 'linux', 05:13:47 INFO - 'TMOUT': '86400', 05:13:47 INFO - 'USER': 'cltbld', 05:13:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:47 INFO - '_': '/tools/buildbot/bin/python'} 05:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:47 INFO - Running setup.py (path:/tmp/pip-0sXgo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:47 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:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:48 INFO - Running setup.py (path:/tmp/pip-q2dNvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:48 INFO - Running setup.py (path:/tmp/pip-6GrNgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:48 INFO - Running setup.py (path:/tmp/pip-CZdES9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:48 INFO - Running setup.py (path:/tmp/pip-MiHTV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:48 INFO - Running setup.py (path:/tmp/pip-QpPXNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:48 INFO - Running setup.py (path:/tmp/pip-sPGkJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:48 INFO - Running setup.py (path:/tmp/pip-XpeekO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:48 INFO - Running setup.py (path:/tmp/pip-tKSXR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:48 INFO - Running setup.py (path:/tmp/pip-hPAcyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:48 INFO - Running setup.py (path:/tmp/pip-kPytkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:48 INFO - Running setup.py (path:/tmp/pip-x_HAa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:48 INFO - Running setup.py (path:/tmp/pip-G57QpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:48 INFO - Running setup.py (path:/tmp/pip-84ta3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:48 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:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:48 INFO - Running setup.py (path:/tmp/pip-EK8icd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:49 INFO - Running setup.py (path:/tmp/pip-hmmQUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:49 INFO - Running setup.py (path:/tmp/pip-ycWfTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13: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:13: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:13: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:13: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:13: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:13: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:13:51 INFO - Downloading blessings-1.6.tar.gz 05:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:51 INFO - Installing collected packages: blessings 05:13:51 INFO - Running setup.py install for blessings 05:13:51 INFO - Successfully installed blessings 05:13:51 INFO - Cleaning up... 05:13:51 INFO - Return code: 0 05:13:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:51 INFO - Reading from file tmpfile_stdout 05:13:51 INFO - Current package versions: 05:13:51 INFO - argparse == 1.2.1 05:13:51 INFO - blessings == 1.6 05:13:51 INFO - blobuploader == 1.2.4 05:13:51 INFO - docopt == 0.6.1 05:13:51 INFO - functools32 == 3.2.3-2 05:13:51 INFO - jsonschema == 2.5.1 05:13:51 INFO - manifestparser == 1.1 05:13:51 INFO - mozInstall == 1.12 05:13:51 INFO - mozcrash == 0.17 05:13:51 INFO - mozdebug == 0.1 05:13:51 INFO - mozdevice == 0.48 05:13:51 INFO - mozfile == 1.2 05:13:51 INFO - mozhttpd == 0.7 05:13:51 INFO - mozinfo == 0.9 05:13:51 INFO - mozleak == 0.1 05:13:51 INFO - mozlog == 3.2 05:13:51 INFO - moznetwork == 0.27 05:13:51 INFO - mozprocess == 0.22 05:13:51 INFO - mozprofile == 0.28 05:13:51 INFO - mozrunner == 6.11 05:13:51 INFO - mozscreenshot == 0.1 05:13:51 INFO - mozsystemmonitor == 0.3 05:13:51 INFO - moztest == 0.7 05:13:51 INFO - mozversion == 1.4 05:13:51 INFO - psutil == 3.1.1 05:13:51 INFO - requests == 1.2.3 05:13:51 INFO - wsgiref == 0.1.2 05:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:51 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 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13:51 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:13:51 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:13:51 INFO - Using env: {'DISPLAY': ':0', 05:13:51 INFO - 'HOME': '/home/cltbld', 05:13:51 INFO - 'LANG': 'en_US.UTF-8', 05:13:51 INFO - 'LANGUAGE': 'en_US:en', 05:13:51 INFO - 'LOGNAME': 'cltbld', 05:13:51 INFO - 'MAIL': '/var/mail/cltbld', 05:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:51 INFO - 'MOZ_NO_REMOTE': '1', 05:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:51 INFO - 'NO_EM_RESTART': '1', 05:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:51 INFO - 'PWD': '/builds/slave/test', 05:13:51 INFO - 'SHELL': '/bin/bash', 05:13:51 INFO - 'SHLVL': '1', 05:13:51 INFO - 'TERM': 'linux', 05:13:51 INFO - 'TMOUT': '86400', 05:13:51 INFO - 'USER': 'cltbld', 05:13:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:51 INFO - '_': '/tools/buildbot/bin/python'} 05:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 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:13:51 INFO - Cleaning up... 05:13:51 INFO - Return code: 0 05:13:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:13: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:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13: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'] in /builds/slave/test/build 05:13: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 05:13:51 INFO - Using env: {'DISPLAY': ':0', 05:13:51 INFO - 'HOME': '/home/cltbld', 05:13:51 INFO - 'LANG': 'en_US.UTF-8', 05:13:51 INFO - 'LANGUAGE': 'en_US:en', 05:13:51 INFO - 'LOGNAME': 'cltbld', 05:13:51 INFO - 'MAIL': '/var/mail/cltbld', 05:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:51 INFO - 'MOZ_NO_REMOTE': '1', 05:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:51 INFO - 'NO_EM_RESTART': '1', 05:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:51 INFO - 'PWD': '/builds/slave/test', 05:13:51 INFO - 'SHELL': '/bin/bash', 05:13:51 INFO - 'SHLVL': '1', 05:13:51 INFO - 'TERM': 'linux', 05:13:51 INFO - 'TMOUT': '86400', 05:13:51 INFO - 'USER': 'cltbld', 05:13:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:51 INFO - '_': '/tools/buildbot/bin/python'} 05:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:13:51 INFO - Cleaning up... 05:13:51 INFO - Return code: 0 05:13:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:13: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:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72e0270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', '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:13: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', 'flake8'] in /builds/slave/test/build 05:13: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 flake8 05:13:51 INFO - Using env: {'DISPLAY': ':0', 05:13:51 INFO - 'HOME': '/home/cltbld', 05:13:51 INFO - 'LANG': 'en_US.UTF-8', 05:13:51 INFO - 'LANGUAGE': 'en_US:en', 05:13:51 INFO - 'LOGNAME': 'cltbld', 05:13:51 INFO - 'MAIL': '/var/mail/cltbld', 05:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:51 INFO - 'MOZ_NO_REMOTE': '1', 05:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:51 INFO - 'NO_EM_RESTART': '1', 05:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:51 INFO - 'PWD': '/builds/slave/test', 05:13:51 INFO - 'SHELL': '/bin/bash', 05:13:51 INFO - 'SHLVL': '1', 05:13:51 INFO - 'TERM': 'linux', 05:13:51 INFO - 'TMOUT': '86400', 05:13:51 INFO - 'USER': 'cltbld', 05:13:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:51 INFO - '_': '/tools/buildbot/bin/python'} 05:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:52 INFO - Downloading/unpacking flake8 05:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13: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:13: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:13: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:13: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:13: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:13: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:13:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13: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:13: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:13: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:13: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:13: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:13: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:13:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13: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:13: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:13: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:13: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:13: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:13: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:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:54 INFO - no previously-included directories found matching 'docs/_build' 05:13:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:54 INFO - Running setup.py install for pep8 05:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:54 INFO - no previously-included directories found matching 'docs/_build' 05:13:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:13:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:54 INFO - Cleaning up... 05:13:55 INFO - Return code: 0 05:13:55 INFO - Running post-action listener: _resource_record_post_action 05:13:55 INFO - Running post-action listener: _start_resource_monitoring 05:13:55 INFO - Starting resource monitoring. 05:13:55 INFO - ##### 05:13:55 INFO - ##### Finished create-virtualenv step (success) 05:13:55 INFO - ##### 05:13:55 INFO - ##### 05:13:55 INFO - ##### Running install step. 05:13:55 INFO - ##### 05:13:55 INFO - Running pre-action listener: _resource_record_pre_action 05:13:55 INFO - Running main action method: install 05:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:55 INFO - Reading from file tmpfile_stdout 05:13:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:55 INFO - Reading from file tmpfile_stdout 05:13:55 INFO - Output received: 05:13:55 INFO - Usage: mozinstall [options] installer 05:13:55 INFO - Options: 05:13:55 INFO - -h, --help show this help message and exit 05:13:55 INFO - -d DEST, --destination=DEST 05:13:55 INFO - Directory to install application into. [default: 05:13:55 INFO - "/builds/slave/test"] 05:13:55 INFO - --app=APP Application being installed. [default: firefox] 05:13:55 INFO - mkdir: /builds/slave/test/build/application 05:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:14:12 INFO - Reading from file tmpfile_stdout 05:14:12 INFO - Output received: 05:14:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:14:12 INFO - Running post-action listener: _resource_record_post_action 05:14:12 INFO - ##### 05:14:12 INFO - ##### Finished install step (success) 05:14:12 INFO - ##### 05:14:12 INFO - ##### 05:14:12 INFO - ##### Running run-tests step. 05:14:12 INFO - ##### 05:14:12 INFO - Running pre-action listener: _resource_record_pre_action 05:14:12 INFO - Running main action method: run_tests 05:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:14:12 INFO - Python 2.7.3 05:14:12 INFO - Return code: 0 05:14:12 INFO - grabbing minidump binary from tooltool 05:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:12 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 0x14531c0>, '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 0x14540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1454550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:14:12 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:14:12 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:14:12 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:14:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:12 INFO - Return code: 0 05:14:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:14:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:14:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:14:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:14:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:14:13 INFO - Return code: 0 05:14:13 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/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:14:13 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/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:14:13 INFO - Using env: {'DISPLAY': ':0', 05:14:13 INFO - 'HOME': '/home/cltbld', 05:14:13 INFO - 'LANG': 'en_US.UTF-8', 05:14:13 INFO - 'LANGUAGE': 'en_US:en', 05:14:13 INFO - 'LOGNAME': 'cltbld', 05:14:13 INFO - 'MAIL': '/var/mail/cltbld', 05:14:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:13 INFO - 'MOZ_NO_REMOTE': '1', 05:14:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:13 INFO - 'NO_EM_RESTART': '1', 05:14:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:13 INFO - 'PWD': '/builds/slave/test', 05:14:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:13 INFO - 'SHELL': '/bin/bash', 05:14:13 INFO - 'SHLVL': '1', 05:14:13 INFO - 'TERM': 'linux', 05:14:13 INFO - 'TMOUT': '86400', 05:14:13 INFO - 'USER': 'cltbld', 05:14:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128', 05:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:13 INFO - '_': '/tools/buildbot/bin/python'} 05:14:13 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/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:14:13 INFO - mozversion application_buildid: 20160623023010 05:14:13 INFO - mozversion application_changeset: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 05:14:13 INFO - mozversion application_display_name: Nightly 05:14:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:13 INFO - mozversion application_name: Firefox 05:14:13 INFO - mozversion application_remotingname: firefox 05:14:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:14:13 INFO - mozversion application_vendor: Mozilla 05:14:13 INFO - mozversion application_version: 50.0a1 05:14:13 INFO - mozversion platform_buildid: 20160623023010 05:14:13 INFO - mozversion platform_changeset: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 05:14:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:14:13 INFO - mozversion platform_version: 50.0a1 05:14:13 INFO - using testdate: 1466684053 05:14:13 INFO - actual date: 1466684053 05:14:13 INFO - starting webserver on 'localhost:55811' 05:14:13 INFO - SUITE-START | Running 2 tests 05:14:13 INFO - TEST-START | dromaeo_css 05:14:13 INFO - operating with platform_type : linux_ 05:14:13 INFO - Initialising browser for dromaeo_css test... 05:14:13 INFO - TEST-INFO | started process 18783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIqObgX/profile http://localhost:55811/getInfo.html) 05:14:17 INFO - PROCESS | 18783 | __metrics Screen width/height:1600/1200 05:14:17 INFO - PROCESS | 18783 | colorDepth:24 05:14:17 INFO - PROCESS | 18783 | Browser inner width/height: 1024/697 05:14:17 INFO - PROCESS | 18783 | __metrics 05:14:18 INFO - PROCESS | 18783 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:19 INFO - TEST-INFO | 18783: exit 0 05:14:19 INFO - Browser initialized. 05:14:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:19 INFO - TEST-INFO | started process 18866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIqObgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:31 INFO - PROCESS | 18866 | RSS: Main: 174043136 05:14:31 INFO - PROCESS | 18866 | 05:15:23 INFO - PROCESS | 18866 | 1466684123065 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:17:31 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55811/tests/dromaeo/cssquery-ext.html) 05:17:32 INFO - PROCESS | 18866 | RSS: Main: 286437376 05:17:32 INFO - PROCESS | 18866 | 05:20:35 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-ext.html (next: http://localhost:55811/tests/dromaeo/cssquery-jquery.html) 05:20:35 INFO - PROCESS | 18866 | RSS: Main: 262602752 05:20:35 INFO - PROCESS | 18866 | 05:23:37 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55811/tests/dromaeo/cssquery-mootools.html) 05:23:38 INFO - PROCESS | 18866 | RSS: Main: 265101312 05:23:38 INFO - PROCESS | 18866 | 05:26:40 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55811/tests/dromaeo/cssquery-prototype.html) 05:26:40 INFO - PROCESS | 18866 | RSS: Main: 256323584 05:26:40 INFO - PROCESS | 18866 | 05:29:43 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55811/tests/dromaeo/cssquery-yui.html) 05:29:43 INFO - PROCESS | 18866 | RSS: Main: 245510144 05:29:43 INFO - PROCESS | 18866 | 05:32:46 INFO - PROCESS | 18866 | Cycle 1(1): loaded http://localhost:55811/tests/dromaeo/cssquery-yui.html (next: http://localhost:55811/tests/dromaeo/cssquery-dojo.html) 05:32:47 INFO - PROCESS | 18866 | RSS: Main: 290701312 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | __start_tp_report 05:32:47 INFO - PROCESS | 18866 | _x_x_mozilla_page_load 05:32:47 INFO - PROCESS | 18866 | _x_x_mozilla_page_load_details 05:32:47 INFO - PROCESS | 18866 | |i|pagename|runs| 05:32:47 INFO - PROCESS | 18866 | |0;dojo.html;3049;3060.831654259015;3072.6466456357525;3084.367704620552;3131.1858916681654;5145.794168233266;5189.040027594893;5234.953009398117;5316.20256961456;5333.3866605340345;5218.660787048839;5252.763625636846;5304.602154838393;5361.115415956372;5372.7313634318325;4759.833405830788;4794.9520504794855;4797.208460603996;4875.512448755132;4984.22744474607;4831.154547954094;4900.460949295592;4954.7522623868845;4957.5786058185095;4997.875053123665;4774.069056533977;4816.903661926777;4831.9275210871865;4848.927266091011;4849.054434385296;4869.2939523768855;4871.853844384674;4875.122477953967;4877.975610121962;4881.975590122062;4681.32120842476;4715.3634259374885;4840.636952228597;4845.927311090337;4847.733374664392;5204.687718736888;5211.635185537014;5267.236250743659;5309.389420216686;5319.867003324909;5653.321601407816;5657.8585535361535;5662.631928924607;5664.8867022659315;5666.744996475169;5509.146082357241;5565.5825813063775;5594.776208951637;5602.215689803431;5609.831705048855;5257.106291930381;5290.867728306785;5292.947070529284;5316.494932981361;5319.46805319465;5622.550195984311;5753.568482363756;5756.94243057564;5757.0788673811985;5764.596478246483;5483.945160548423;5529.668219906818;5544.77820887168;5547.25112109868;5604.019296623074;5642.633228840113;5646.322441307069;5680.545556355564;5684.971575142098;5701.2588363513305;5423.566114710814;5480.013597552399;5641.294838145232;5645.5483561314995;5654.208410822488;5537.36320323168;5572.944270557243;5575.498205161555;5581.190727344512;5592.832215033555;4283.100548884707;4285.742855428684;4288.678349123828;4289.742615443021;4325.740455572675;3824.9808750956067;3833.6933045356304;3846.480725102131;3882.378819388884;3889.2610404023144;5339.813106541253;5361.597880158925;5361.812336568201;5363.812266570651;5400.459954004568;5635.408282130399;5638.605297629127;5638.802641907513;5651.689157096399;5696.060150075274;5178.922316165261;5225.947740522623;5315.521603055744;5328.573714102862;5355.785768569292;4870.4155501340065;4878.82924097662;4901.460839307673;4910.165271903785;4948.950510494849;5778.456170955091;5793.855153621109;5824.825255242349;5830.4461076197695;5831.212786273799;5471.2887324647545;5608.85977850557;5667.773289068391;5674.517665998436;5677.801276955287;5833.270841144857;5836.912446313224;5845.269341332333;5853.268341457318;5861.472467477947;5436.619436639556;5566.582506311962;5567.5545956322585;5571.8885622288135;5573.247611572548;5568.470995255444;5636.267285252891;5660.235868157746;5701.287339082614;5704.857378565569;5476.452354764491;5480.040992826319;5485.50630443262;5486.177073439016;5487.149491828773;5408.675479471244;5426.565874730091;5460.808871689472;5468.507834294774;5508.44915508446;5328;5419.701916394636;5434.184872269033;5438.428964958781;5483.177523371526;5540.556755459473;5540.584456165723;5601.971990140023;5604.85987850307;5606.607537472338;5265.447128051499;5317.627766056494;5334.333208348957;5424.294841670716;5429.375621803543 05:32:47 INFO - PROCESS | 18866 | |1;ext.html;590.2798585725416;601.3925934805847;621.0559948877706;632.1150389454763;641.8748344072908;31078.37843243134;31629.051128466126;43028.99999999996;43659.563404365945;43702.344464832975;41129.794351028206;45256.32115518262;45272.32091518622;45352.77323613386;45415.31877021839;8874.95562522188;9022.54887255638;9026.593803278869;9027.187553120219;9029.503377314246;8870.822583548324;8899.777505562348;8967.372283940127;8980.775480613005;8991;9002.189802917736;9076.8638470423;9110.77223069422;9116.27069834415;9121.771955701128;8988.77528061797;9018.503982280972;9030.051844556292;9037.141471560224;9041.593128309176;8871.733847984571;8913.420627659181;8932.8660070099;8938.553072346422;8939;42761.572384276384;42812.35781463281;43153.568464315584;43183.35224971628;43184.13631727379;3577.141486043357;3624.619414961444;3727;3734.719896007783;3774.3960966245268;31385.686143138504;33658.679106066695;34428.65571344305;34833.12917177091;35443.64556354455;4523.208438523278;4623.8150473981;4639.953600463986;4666.463356713987;4669.88325291867;371597;377688;379384.1030794856;380805;382579;61830.381696183365;63742.6812865942;63991.680041599495;65372.67313663496;66243;61541.69229153825;66391;66553.33446665568;66617.33382666208;74954;16752.162391880356;16813.91593042027;16814.15929203535;16840.74738878918;16844.578885527713;13857.30713464343;14114.082584631966;14179.078359906573;14213.076150050421;14215.715685686228;20721.171153154006;21093.894530527556;21189.258375957077;21265.68101478479;21391.358259252247;6419.775307864203;7615.581143037075;7756;7817.3030304544845;7863.37093032556;1000.799840031982;1019.0522813783105;1047.8847326794198;1160.3386069940223;1164.6268262673607;32598.185045374055;33084;33291.500627490605;33546.61107814158;33742;1108.41808050774;1123.601121601836;1176.1884299833089;1209.2140108929266;1255.1151438236204;16690.248938797784;17398.65202695939;17417.100008475878;17498.825011749974;17547.575046201437;605212;610046;610827;611574;613049;60890.69554652199;60941.08588371178;61021.694891526146;61290;61443.6927815367;1227.2820400066062;1345.5290648273221;1351.4459071780523;1356.409961666678;1365.3719289127114;32737.50893736548;34179.658203417646;34372.65627343795;34391.48412773861;34671.479927800596;45727;46076.30885536653;46223;46326;46384;422519;423466;424014;424523;424673;28599.28501787472;29480.2311861289;29615.703842961295;31091.222719432197;45596.77201614103;50182.2472662903;50344;50673.74663126661;50691.74654126706;51461.22808157955;42962.78518607387;43664;43674.563254368324;44300;44771.32843007292;41323.1735365297;41325.79337103295;41601.791991041064;42147;42322.576774231864;41859.58140418557;42474;42719.35920961126;42799.57200427956;45718.542814571425;35608.82195589005;38582.035449113995;38759.418608721455;38830.611693882696;38855.61144388633;28743.137705868856;29096.01555199032;29383.412331753672;29389.26526836846;29442.26394340073 05:32:47 INFO - PROCESS | 18866 | |2;jquery.html;377.77333599840097;380.31163593895053;382.800943509375;395.45427310311766;404.4136002795947;17496.562585935342;18736.718949215774;19093.42719718407;19095.52261193471;19102.331418400358;17790.199441025154;18618.813811861877;19250;19564.706529402036;19601.411957641292;5028.094942910275;5041.193409054552;5187.118189907725;5221.79112835488;5222.869428264305;5094.592432605401;5104.6937183768905;5120.615953803461;5126.026055049548;5137.717425541594;5017.37282839645;5206.0368831766245;5219.765110570014;5227.634065615409;5231.189165679307;5085.898282034357;5149.948500515003;5163.457836927106;5197.480251974791;5206.0368831766245;4887.462379138292;5057.912548802025;5059.038782631288;5062.519060689266;5063.341765570489;13250.138740981805;13270.469181232738;13494.392752326168;13515.121517101357;13531.985101117456;2169.2516081951703;2236.3514580771557;2297.310806757966;2407.57867373209;2545.2237067694346;9816.95091524545;9852.458114803683;10147.441890696009;10316.071553560216;10321.071103600712;1903.9524011899675;1918.3285849952545;1919.3378284491966;1964.803519648038;1987.592543528573;77615;78520;78594.60702696507;78887;83151.58424207901;10995.945020274847;11063.336199828036;11101.500432480558;11165.385903775208;11250.324980501033;15268.541943741706;15339.463118790789;15447.227638618024;15454.768178477332;15458.072515649097;8302.335813134934;8477.98264208299;8686.782830429163;8729.476231426008;8729.519876406732;8372.874406883902;8433.831323373499;8468.872966905377;8595.828083438297;8632.827343453097;4745.098431298043;4754.263089221176;4789.090072886141;4862.222044472867;4874.5856602188505;1804.42258477286;1882.4070417818343;1934.9033294058563;1940.9126589303514;1992.581557872863;872.7818045488627;904.8687940248627;945.8628498867763;954.737447202025;996.7707427291764;18654.720179197324;19110.530149575454;19601.803981959998;19839.900800495907;20138.295159669633;968.375397868385;983.5819776594918;985.3989066669326;1012.6658202793208;1019.2202964731986;10637.680869573926;11096.778064438666;11106.389148596743;11176.944115279533;11197.66407007791;441609;447129;448491;456409;460691;86223;89079.10920890838;90050.54974725084;90676;90780;1002.7242508310273;1007.7631756537354;1036.362636978268;1070.7644318249972;1072.9034386905216;17233.56916077108;17292.654146917244;17299.13504324804;17433.389831355842;17663.20515576828;40048.79975600103;40585.391219132325;40748.1850362997;41897;42183.578164217965;55506.167407488116;56745;57713.71143144257;58255.70872145612;58389.4161058401;7548.849023019399;7685.193054729173;7703.653335600024;7873.409494287836;8304.958475207586;9591.376560523544;13501.662458438617;13597.305217906185;13668.111572747739;13988.510402136284;11943.940280298542;12006.399680016139;12143.939280303543;12158.452869621065;12205.755884882075;11648.650540483799;11733;11824.645260642195;12047.33739644328;12176.512939482322;12001.579944701894;12121.636350909486;12182.817257740964;12278.263304201777;12415.62753117408;7863.263164699874;7865.567393793396;8117.350611951148;8121.4721043132;8238.546879921421;10880.183986200907;12111.818322725343;12185.634430967086;12263.816042759545;12293.44679489443 05:32:47 INFO - PROCESS | 18866 | |3;mootools.html;1280.7822670146074;1371.5611004478565;1435.468876515689;1501.692153108613;1709.7435384692303;7685.077790665121;7937.404694647896;7946.364290856732;7948.7217947371855;8181.590920453983;7709.845803083935;7938.6824527019;8157.959210203955;8195.59022048898;8196.262336389724;1988.3239698502578;2153.8599991000533;2175.5105101352187;2209;2229.1640634761966;2229.9219527316545;2234.620114580517;2236.0385034435185;2238.2837492002564;2249.932502024934;2195.045155357425;2224.3882932193696;2260.152442833937;2262.061244583496;2265.1392470861133;1902.628987347461;2085.113826623679;2166.71832661753;2170.1970270999673;2204.40481070111;2076.8961551922494;2078.833693304532;2086.937391878246;2098.8111070003774;2098.842586805996;8166.918330816675;8218.589070546508;8232.753017409488;8233.34133269343;8239.340852731768;4791.6406269529925;4923.458419573844;4935.80256789728;4938.9012219755405;4946.530079642428;3152.401043801693;3218.5494030835466;3218.6298575663864;3218.935621287561;3225.4194245035883;1031.8710161229847;1038.5430410619304;1054.2988912373262;1055.6199768083484;1067.5729708116737;10945.56217751289;11177.944110279397;11181;11182.720431989266;11187;4140.171965606891;4202.054537729047;4225.9577404226175;4278.251306021434;4319.935200971988;9484.193843523377;9494.857577136348;9500.667476638422;9503.382280151767;9567.091126342986;4856.757162141878;4859.829905953275;4868.659193856467;4869.975650121798;4874.5856602188505;3991.560928297885;4430.955690443118;4533.297338912474;4535.455745310518;4616.722996620214;3610.6930910872343;3669.908252293714;3712.0348709335767;3743.082944678517;3756.154865155318;1082.3884505254507;1088.4775307852276;1125.9774804503863;1142.874283828778;1143.0455569599312;790.1387487638386;898.3127907151035;902.5983437370438;913.6482454255159;913.7761248494162;5706.828795136153;5786.074228123564;5932.970335148297;5933.970330148408;5953.970230148908;923.8660394242797;931.2875650127658;934.149923569562;936.2509992006368;961.6393852305386;3947.703922205846;4116.279651061112;4121.216968775923;4123.649489793401;4130.958690413117;10057.647982320585;10333.276670633133;10365.585376585002;10462.947685261524;10475.423851688078;10336.121429678562;10346.948265258625;10369;10373;10381.429021403896;7409.296116868889;7771.261730135628;7886;7907.446478746432;7914.960425197953;5723.599348045764;5799.94200057994;5861.589688721919;5914.763409463745;5940.108983652487;8623.655053797778;9457.33798634089;9495.715128546155;9567.138957493858;9599.664011759554;9014.86477702848;9061.909380906107;9084.227840633355;9102.772430689285;9110.088991100836;6674.733010679713;7128.073350464407;7225.710971561289;7300;7483.176850546544;8029.959850200945;8046.396520260887;8121.959390203011;8127.674893004214;8129.4715843469985;7167.964160179375;7182.497225194186;7238.384737297178;7371.189169191277;7455.813604659927;7214.206437291999;7231.5299505531975;7238.927610723826;7266.200717920919;7337.779866604011;6677.699503522256;6760.797176084725;6766.560173588701;6770.086038384952;6776.491763117688;4773.522647735337;4963.726995015309;4964.528369804862;4990.101781679333;5064.316317297265;5106.336176297058;5108.106081435808;5112.079825631274;5279.920801187908;5316.441773613715 05:32:47 INFO - PROCESS | 18866 | |4;prototype.html;276.24584883268676;286.39902942551134;303.2313086326164;308.49406972565;311.0652489269745;5004.399472063348;5182.663126896749;5188.558972487338;5197.792088316468;5217.373915130185;5180.093483640358;5226;5246.793237555365;5259.76331065103;5260.368755749316;4069.633732964025;4082.530508991474;4092.4244165996006;4105.753654780708;4110.177964407116;3851.557070936836;3902.0635047588657;4048.412980117881;4064.6748260139266;4127.649149822269;4005.459262999487;4023.356262997921;4052.29084910141;4059.4316795648633;4060.817263223147;4028.81870315835;4036.192761447722;4047.1096358801015;4070.450489183952;4070.7354021988476;3536.6463353664685;3623.492711020433;3625.619309972468;3630.2376500934834;3637.4543818427182;5043.596512279046;5047.0915235257635;5068.949310506885;5079.288899554065;5082.79668813247;4579.862604121881;4589.747563883985;4592.33411155384;4593.747343896084;4599.31010348447;5139.58883289336;5397.892042159174;5399.325084364455;5417.6478528895495;5443;3887.786171760552;3896.5713771485116;3912.4522566840665;3912.882613521599;3921.941170882439;5559.138333558305;5566.832995010156;5694.259746232963;5706.115552089392;5727.05503591911;4098.057446787256;4098.774567398762;4099.508059032935;4100.7334523255895;4109.0959988802415;3862.8454861805776;3986.940195897064;4023.657989070903;4045.8988525287104;4063.227986682521;4611.584957353787;4613.546732779164;4618.838340658061;4626.190416677068;4661.160991021581;5445.965266599413;5449;5457.808976685877;5496.340439147328;5500.559955203574;1271.5740227023866;1279.1621487925424;1379.6206043338161;1390.4577214886203;1393.477445957766;847.9830403391898;878.4992554244147;892.6607889002267;896.1844721303582;902.6569903436653;4638.675292729544;4646.767661616906;4650.232711602615;4670.906581868411;4676.3686902267755;4894.486078961729;4928.457869634337;4936.531029552187;4937.827176048893;4952.47998960104;4622.791974361162;4658.906821863544;4685.554872287127;4711.811527538928;4721.504242054603;2766.4190519991025;2957.9112626621236;3002.894898678536;3014.7136022077866;3015.8793648254264;5808.3901190375245;5830.212921255661;5832.1834943108;5837.970810145922;5839.708014599253;5457.317835270591;5671.370322993288;5718.228039214736;5722.37053924068;5750.6262092963825;5721;5766.221560089334;5786.161006654096;5798.115612425979;5802.2747156606265;5626.43735626434;5662.631928924607;5663.32040155184;5684.602077854676;5705.087186050212;5343.438938911514;5548.306461692288;5615.438456154352;5668.801591944262;5673.744681489426;5709.486146246858;5736.569757268305;5767.163761254678;5781.93034288658;5878.353381127987;3870.5161854768153;3958.1687845552756;3964.4053391991433;3967.1272320089533;3976.741511801724;5461.754221060141;5468.644538105011;5570.2480165177185;5597.384287728265;5605.80379686709;5397.676139431646;5413.10683737179;5466.34403871538;5501.0648189807025;5514.862128446821;5282.234076059027;5436.477786219864;5460.453954604508;5482.17767334903;5501.257330260363;5317.707526086102;5335.359756829205;5368.489993450616;5398.379186393615;5399.163129714901;5415.6479828811;5489.725513724377;5493.121100623881;5503.174523821459;5507.394186639386;5219.399769026611;5381.11211650089;5438.809641662523;5456.372517160418;5465.890682186255 05:32:47 INFO - PROCESS | 18866 | |5;yui.html;708.2032713197649;723.2514347650183;747.8317378589818;803.7288236875916;806.7297455352458;14676.266186690662;15732.685346293067;15758.684826303466;15779.13214773187;15786.052836829784;14425.567232983001;14722;14878;14940.775888361655;14942.701145977102;798.1499702816511;820.5404973214988;820.659426338069;826.4545400035978;828.2876726015621;798.2137594469443;803.4456225204619;803.8914746509234;807.1565214351017;808.1595141053327;857.34413173922;860.3977215948829;860.4450129666361;860.7546849147994;863.8099618084011;848.3722045686179;849.8980122385292;852.722865068852;853.2534032721369;853.7950891785957;630.867517821258;633.3223450907531;633.5470138850744;633.885900537903;634.2515831319041;13414.664633384145;13450.12574182675;13506.392212350467;13508.459661613524;13531.797023044663;12897.161684490478;13112.934435327763;13184.868151318557;13235;13343.933280333633;10782.784344313148;10888.564457421693;10896.618618348399;11082.944585277102;11087.113030957586;3785.7539259948016;3816.3321418751607;3822.0827001519433;3851.768893866349;4040.8181631826346;49316.75341623305;51431.22853157168;75524.24475755282;76220.23779762187;78816.60591697063;11518.654440366803;11536.826947595793;11620.535178592761;11629.825552616718;12108.939455302843;18609.162587683586;18666.440006799818;18679.439616811516;18685.532861678566;18801.247950082117;8844.115588441104;8881.156290152425;9146.314026448043;9323.347365684336;9336.813263734688;4357.9564204358185;4526.524714904954;4527.569880861313;4551.590356867831;4685.0629874025335;3305.272839975202;3412.4198886189406;3416.4704470807064;3439.7764145330475;3443.5351227583956;598.1954271504819;608.9543284253699;612.0452094732232;627.0938493876305;634.4163369699887;614.2904944788687;685.95541289816;690.1752405874931;699.3041923286363;704.1022696062561;9391.859122113174;9397.671081512251;9415.623375065057;9732.854007189897;9821.36161149523;590.3417689276425;672.6468603982851;694.3542505469961;716.9569825810364;783.3654739660893;4623.907521849612;4880.902381952341;4893.902121957541;5036.647434679538;5115.590752739772;65939;106299.468502657;109974.45012774885;112231;115816.42091789487;95120;98159.50920245353;98705;98942;99179;83693.58153209195;84565.15434845573;84772;85002.1499785019;85829.57085214659;9172.908270917205;9189;9201.539923003957;9241.127286448957;9591.136797688241;48762;50210.24684629807;50281.74859125681;50689;50964.49035509597;73921.63039184769;75497.24502754903;76602.93588256407;76850.61574692314;78161;12539.435725392561;12654.620361389174;12691.42888570035;12699.809502857279;13055.608331750063;13950.419172453128;13979.580612581638;14142.22217778032;14488.420463181776;14944;13151.671208219872;13416.932915335361;13733.519326823513;14007.08953917992;14019.439222430989;12384.504619815107;12867.871321286668;13108.410121544362;13369.53206637763;13444.865551344361;12792.872071279167;13106.541271055466;13783.931080344935;13795.310234488436;13796.517121900686;10637.308574942605;10943.671689849318;10995.285306455055;11170.776584468103;11182.888171118184;11428.48571814287;11609.825852612386;11856.332778569245;12112.75774484523;12216.877831221575 05:32:47 INFO - PROCESS | 18866 | __end_tp_report 05:32:47 INFO - PROCESS | 18866 | __start_cc_report 05:32:47 INFO - PROCESS | 18866 | _x_x_mozilla_cycle_collect,893 05:32:47 INFO - PROCESS | 18866 | __end_cc_report 05:32:47 INFO - PROCESS | 18866 | __startTimestamp1466685167120__endTimestamp 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | ------- Summary: start ------- 05:32:47 INFO - PROCESS | 18866 | Number of tests: 6 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#0] dojo.html Cycles:165 Average:5238.77 Median:5424.29 stddev:579.67 (10.7%) stddev-sans-first:555.41 05:32:47 INFO - PROCESS | 18866 | Values: 3049.0 3060.8 3072.6 3084.4 3131.2 5145.8 5189.0 5235.0 5316.2 5333.4 5218.7 5252.8 5304.6 5361.1 5372.7 4759.8 4795.0 4797.2 4875.5 4984.2 4831.2 4900.5 4954.8 4957.6 4997.9 4774.1 4816.9 4831.9 4848.9 4849.1 4869.3 4871.9 4875.1 4878.0 4882.0 4681.3 4715.4 4840.6 4845.9 4847.7 5204.7 5211.6 5267.2 5309.4 5319.9 5653.3 5657.9 5662.6 5664.9 5666.7 5509.1 5565.6 5594.8 5602.2 5609.8 5257.1 5290.9 5292.9 5316.5 5319.5 5622.6 5753.6 5756.9 5757.1 5764.6 5483.9 5529.7 5544.8 5547.3 5604.0 5642.6 5646.3 5680.5 5685.0 5701.3 5423.6 5480.0 5641.3 5645.5 5654.2 5537.4 5572.9 5575.5 5581.2 5592.8 4283.1 4285.7 4288.7 4289.7 4325.7 3825.0 3833.7 3846.5 3882.4 3889.3 5339.8 5361.6 5361.8 5363.8 5400.5 5635.4 5638.6 5638.8 5651.7 5696.1 5178.9 5225.9 5315.5 5328.6 5355.8 4870.4 4878.8 4901.5 4910.2 4949.0 5778.5 5793.9 5824.8 5830.4 5831.2 5471.3 5608.9 5667.8 5674.5 5677.8 5833.3 5836.9 5845.3 5853.3 5861.5 5436.6 5566.6 5567.6 5571.9 5573.2 5568.5 5636.3 5660.2 5701.3 5704.9 5476.5 5480.0 5485.5 5486.2 5487.1 5408.7 5426.6 5460.8 5468.5 5508.4 5328.0 5419.7 5434.2 5438.4 5483.2 5540.6 5540.6 5602.0 5604.9 5606.6 5265.4 5317.6 5334.3 5424.3 5429.4 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#1] ext.html Cycles:180 Average:63679.52 Median:42780.57 stddev:127908.88 (299.0%) stddev-sans-first:128179.98 05:32:47 INFO - PROCESS | 18866 | Values: 590.3 601.4 621.1 632.1 641.9 31078.4 31629.1 43029.0 43659.6 43702.3 41129.8 45256.3 45272.3 45352.8 45415.3 8875.0 9022.5 9026.6 9027.2 9029.5 8870.8 8899.8 8967.4 8980.8 8991.0 9002.2 9076.9 9110.8 9116.3 9121.8 8988.8 9018.5 9030.1 9037.1 9041.6 8871.7 8913.4 8932.9 8938.6 8939.0 42761.6 42812.4 43153.6 43183.4 43184.1 3577.1 3624.6 3727.0 3734.7 3774.4 31385.7 33658.7 34428.7 34833.1 35443.6 4523.2 4623.8 4640.0 4666.5 4669.9 371597.0 377688.0 379384.1 380805.0 382579.0 61830.4 63742.7 63991.7 65372.7 66243.0 61541.7 66391.0 66553.3 66617.3 74954.0 16752.2 16813.9 16814.2 16840.7 16844.6 13857.3 14114.1 14179.1 14213.1 14215.7 20721.2 21093.9 21189.3 21265.7 21391.4 6419.8 7615.6 7756.0 7817.3 7863.4 1000.8 1019.1 1047.9 1160.3 1164.6 32598.2 33084.0 33291.5 33546.6 33742.0 1108.4 1123.6 1176.2 1209.2 1255.1 16690.2 17398.7 17417.1 17498.8 17547.6 605212.0 610046.0 610827.0 611574.0 613049.0 60890.7 60941.1 61021.7 61290.0 61443.7 1227.3 1345.5 1351.4 1356.4 1365.4 32737.5 34179.7 34372.7 34391.5 34671.5 45727.0 46076.3 46223.0 46326.0 46384.0 422519.0 423466.0 424014.0 424523.0 424673.0 28599.3 29480.2 29615.7 31091.2 45596.8 50182.2 50344.0 50673.7 50691.7 51461.2 42962.8 43664.0 43674.6 44300.0 44771.3 41323.2 41325.8 41601.8 42147.0 42322.6 41859.6 42474.0 42719.4 42799.6 45718.5 35608.8 38582.0 38759.4 38830.6 38855.6 28743.1 29096.0 29383.4 29389.3 29442.3 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#2] jquery.html Cycles:180 Average:27430.11 Median:381.56 stddev:74528.58 (19532.8%) stddev-sans-first:74709.97 05:32:47 INFO - PROCESS | 18866 | Values: 377.8 380.3 382.8 395.5 404.4 17496.6 18736.7 19093.4 19095.5 19102.3 17790.2 18618.8 19250.0 19564.7 19601.4 5028.1 5041.2 5187.1 5221.8 5222.9 5094.6 5104.7 5120.6 5126.0 5137.7 5017.4 5206.0 5219.8 5227.6 5231.2 5085.9 5149.9 5163.5 5197.5 5206.0 4887.5 5057.9 5059.0 5062.5 5063.3 13250.1 13270.5 13494.4 13515.1 13532.0 2169.3 2236.4 2297.3 2407.6 2545.2 9817.0 9852.5 10147.4 10316.1 10321.1 1904.0 1918.3 1919.3 1964.8 1987.6 77615.0 78520.0 78594.6 78887.0 83151.6 10995.9 11063.3 11101.5 11165.4 11250.3 15268.5 15339.5 15447.2 15454.8 15458.1 8302.3 8478.0 8686.8 8729.5 8729.5 8372.9 8433.8 8468.9 8595.8 8632.8 4745.1 4754.3 4789.1 4862.2 4874.6 1804.4 1882.4 1934.9 1940.9 1992.6 872.8 904.9 945.9 954.7 996.8 18654.7 19110.5 19601.8 19839.9 20138.3 968.4 983.6 985.4 1012.7 1019.2 10637.7 11096.8 11106.4 11176.9 11197.7 441609.0 447129.0 448491.0 456409.0 460691.0 86223.0 89079.1 90050.5 90676.0 90780.0 1002.7 1007.8 1036.4 1070.8 1072.9 17233.6 17292.7 17299.1 17433.4 17663.2 40048.8 40585.4 40748.2 41897.0 42183.6 55506.2 56745.0 57713.7 58255.7 58389.4 7548.8 7685.2 7703.7 7873.4 8305.0 9591.4 13501.7 13597.3 13668.1 13988.5 11943.9 12006.4 12143.9 12158.5 12205.8 11648.7 11733.0 11824.6 12047.3 12176.5 12001.6 12121.6 12182.8 12278.3 12415.6 7863.3 7865.6 8117.4 8121.5 8238.5 10880.2 12111.8 12185.6 12263.8 12293.4 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#3] mootools.html Cycles:180 Average:5439.66 Median:4955.13 stddev:3049.46 (61.5%) stddev-sans-first:3041.99 05:32:47 INFO - PROCESS | 18866 | Values: 1280.8 1371.6 1435.5 1501.7 1709.7 7685.1 7937.4 7946.4 7948.7 8181.6 7709.8 7938.7 8158.0 8195.6 8196.3 1988.3 2153.9 2175.5 2209.0 2229.2 2229.9 2234.6 2236.0 2238.3 2249.9 2195.0 2224.4 2260.2 2262.1 2265.1 1902.6 2085.1 2166.7 2170.2 2204.4 2076.9 2078.8 2086.9 2098.8 2098.8 8166.9 8218.6 8232.8 8233.3 8239.3 4791.6 4923.5 4935.8 4938.9 4946.5 3152.4 3218.5 3218.6 3218.9 3225.4 1031.9 1038.5 1054.3 1055.6 1067.6 10945.6 11177.9 11181.0 11182.7 11187.0 4140.2 4202.1 4226.0 4278.3 4319.9 9484.2 9494.9 9500.7 9503.4 9567.1 4856.8 4859.8 4868.7 4870.0 4874.6 3991.6 4431.0 4533.3 4535.5 4616.7 3610.7 3669.9 3712.0 3743.1 3756.2 1082.4 1088.5 1126.0 1142.9 1143.0 790.1 898.3 902.6 913.6 913.8 5706.8 5786.1 5933.0 5934.0 5954.0 923.9 931.3 934.1 936.3 961.6 3947.7 4116.3 4121.2 4123.6 4131.0 10057.6 10333.3 10365.6 10462.9 10475.4 10336.1 10346.9 10369.0 10373.0 10381.4 7409.3 7771.3 7886.0 7907.4 7915.0 5723.6 5799.9 5861.6 5914.8 5940.1 8623.7 9457.3 9495.7 9567.1 9599.7 9014.9 9061.9 9084.2 9102.8 9110.1 6674.7 7128.1 7225.7 7300.0 7483.2 8030.0 8046.4 8122.0 8127.7 8129.5 7168.0 7182.5 7238.4 7371.2 7455.8 7214.2 7231.5 7238.9 7266.2 7337.8 6677.7 6760.8 6766.6 6770.1 6776.5 4773.5 4963.7 4964.5 4990.1 5064.3 5106.3 5108.1 5112.1 5279.9 5316.4 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#4] prototype.html Cycles:180 Average:4544.21 Median:5111.19 stddev:1343.99 (26.3%) stddev-sans-first:1309.03 05:32:47 INFO - PROCESS | 18866 | Values: 276.2 286.4 303.2 308.5 311.1 5004.4 5182.7 5188.6 5197.8 5217.4 5180.1 5226.0 5246.8 5259.8 5260.4 4069.6 4082.5 4092.4 4105.8 4110.2 3851.6 3902.1 4048.4 4064.7 4127.6 4005.5 4023.4 4052.3 4059.4 4060.8 4028.8 4036.2 4047.1 4070.5 4070.7 3536.6 3623.5 3625.6 3630.2 3637.5 5043.6 5047.1 5068.9 5079.3 5082.8 4579.9 4589.7 4592.3 4593.7 4599.3 5139.6 5397.9 5399.3 5417.6 5443.0 3887.8 3896.6 3912.5 3912.9 3921.9 5559.1 5566.8 5694.3 5706.1 5727.1 4098.1 4098.8 4099.5 4100.7 4109.1 3862.8 3986.9 4023.7 4045.9 4063.2 4611.6 4613.5 4618.8 4626.2 4661.2 5446.0 5449.0 5457.8 5496.3 5500.6 1271.6 1279.2 1379.6 1390.5 1393.5 848.0 878.5 892.7 896.2 902.7 4638.7 4646.8 4650.2 4670.9 4676.4 4894.5 4928.5 4936.5 4937.8 4952.5 4622.8 4658.9 4685.6 4711.8 4721.5 2766.4 2957.9 3002.9 3014.7 3015.9 5808.4 5830.2 5832.2 5838.0 5839.7 5457.3 5671.4 5718.2 5722.4 5750.6 5721.0 5766.2 5786.2 5798.1 5802.3 5626.4 5662.6 5663.3 5684.6 5705.1 5343.4 5548.3 5615.4 5668.8 5673.7 5709.5 5736.6 5767.2 5781.9 5878.4 3870.5 3958.2 3964.4 3967.1 3976.7 5461.8 5468.6 5570.2 5597.4 5605.8 5397.7 5413.1 5466.3 5501.1 5514.9 5282.2 5436.5 5460.5 5482.2 5501.3 5317.7 5335.4 5368.5 5398.4 5399.2 5415.6 5489.7 5493.1 5503.2 5507.4 5219.4 5381.1 5438.8 5456.4 5465.9 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - PROCESS | 18866 | [#5] yui.html Cycles:180 Average:19920.91 Median:26821.45 stddev:28497.50 (106.2%) stddev-sans-first:28540.92 05:32:47 INFO - PROCESS | 18866 | Values: 708.2 723.3 747.8 803.7 806.7 14676.3 15732.7 15758.7 15779.1 15786.1 14425.6 14722.0 14878.0 14940.8 14942.7 798.1 820.5 820.7 826.5 828.3 798.2 803.4 803.9 807.2 808.2 857.3 860.4 860.4 860.8 863.8 848.4 849.9 852.7 853.3 853.8 630.9 633.3 633.5 633.9 634.3 13414.7 13450.1 13506.4 13508.5 13531.8 12897.2 13112.9 13184.9 13235.0 13343.9 10782.8 10888.6 10896.6 11082.9 11087.1 3785.8 3816.3 3822.1 3851.8 4040.8 49316.8 51431.2 75524.2 76220.2 78816.6 11518.7 11536.8 11620.5 11629.8 12108.9 18609.2 18666.4 18679.4 18685.5 18801.2 8844.1 8881.2 9146.3 9323.3 9336.8 4358.0 4526.5 4527.6 4551.6 4685.1 3305.3 3412.4 3416.5 3439.8 3443.5 598.2 609.0 612.0 627.1 634.4 614.3 686.0 690.2 699.3 704.1 9391.9 9397.7 9415.6 9732.9 9821.4 590.3 672.6 694.4 717.0 783.4 4623.9 4880.9 4893.9 5036.6 5115.6 65939.0 106299.5 109974.5 112231.0 115816.4 95120.0 98159.5 98705.0 98942.0 99179.0 83693.6 84565.2 84772.0 85002.1 85829.6 9172.9 9189.0 9201.5 9241.1 9591.1 48762.0 50210.2 50281.7 50689.0 50964.5 73921.6 75497.2 76602.9 76850.6 78161.0 12539.4 12654.6 12691.4 12699.8 13055.6 13950.4 13979.6 14142.2 14488.4 14944.0 13151.7 13416.9 13733.5 14007.1 14019.4 12384.5 12867.9 13108.4 13369.5 13444.9 12792.9 13106.5 13783.9 13795.3 13796.5 10637.3 10943.7 10995.3 11170.8 11182.9 11428.5 11609.8 11856.3 12112.8 12216.9 05:32:47 INFO - PROCESS | 18866 | -------- Summary: end -------- 05:32:47 INFO - PROCESS | 18866 | 05:32:47 INFO - TEST-INFO | 18866: exit 0 05:32:47 INFO - TEST-OK | dromaeo_css | took 1114275ms 05:32:47 INFO - TEST-START | kraken 05:32:47 INFO - operating with platform_type : linux_ 05:32:47 INFO - Initialising browser for kraken test... 05:32:47 INFO - TEST-INFO | started process 19055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbkTrg/profile http://localhost:55811/getInfo.html) 05:32:51 INFO - PROCESS | 19055 | __metrics Screen width/height:1600/1200 05:32:51 INFO - PROCESS | 19055 | colorDepth:24 05:32:51 INFO - PROCESS | 19055 | Browser inner width/height: 1024/697 05:32:51 INFO - PROCESS | 19055 | __metrics 05:32:52 INFO - PROCESS | 19055 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:53 INFO - TEST-INFO | 19055: exit 0 05:32:53 INFO - Browser initialized. 05:32:53 INFO - Running cycle 1/1 for kraken test... 05:32:53 INFO - TEST-INFO | started process 19140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbkTrg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:05 INFO - PROCESS | 19140 | RSS: Main: 174653440 05:33:05 INFO - PROCESS | 19140 | 05:33:08 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55811/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:09 INFO - PROCESS | 19140 | RSS: Main: 232296448 05:33:09 INFO - PROCESS | 19140 | 05:33:11 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55811/tests/kraken/driver.html?testName=audio-dft) 05:33:12 INFO - PROCESS | 19140 | RSS: Main: 222093312 05:33:12 INFO - PROCESS | 19140 | 05:33:15 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55811/tests/kraken/driver.html?testName=audio-fft) 05:33:16 INFO - PROCESS | 19140 | RSS: Main: 287211520 05:33:16 INFO - PROCESS | 19140 | 05:33:18 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55811/tests/kraken/driver.html?testName=audio-oscillator) 05:33:19 INFO - PROCESS | 19140 | RSS: Main: 198180864 05:33:19 INFO - PROCESS | 19140 | 05:33:21 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:21 INFO - PROCESS | 19140 | RSS: Main: 202002432 05:33:21 INFO - PROCESS | 19140 | 05:33:24 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55811/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:25 INFO - PROCESS | 19140 | RSS: Main: 238116864 05:33:25 INFO - PROCESS | 19140 | 05:33:28 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55811/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:29 INFO - PROCESS | 19140 | RSS: Main: 238575616 05:33:29 INFO - PROCESS | 19140 | 05:33:32 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55811/tests/kraken/driver.html?testName=json-parse-financial) 05:33:32 INFO - PROCESS | 19140 | RSS: Main: 238608384 05:33:32 INFO - PROCESS | 19140 | 05:33:34 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:34 INFO - PROCESS | 19140 | RSS: Main: 225116160 05:33:34 INFO - PROCESS | 19140 | 05:33:36 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:37 INFO - PROCESS | 19140 | RSS: Main: 229154816 05:33:37 INFO - PROCESS | 19140 | 05:33:39 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:40 INFO - PROCESS | 19140 | RSS: Main: 237285376 05:33:40 INFO - PROCESS | 19140 | 05:33:42 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:43 INFO - PROCESS | 19140 | RSS: Main: 239702016 05:33:43 INFO - PROCESS | 19140 | 05:33:45 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:46 INFO - PROCESS | 19140 | RSS: Main: 237400064 05:33:46 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | Cycle 1(1): loaded http://localhost:55811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55811/tests/kraken/driver.html?testName=ai-astar) 05:33:48 INFO - PROCESS | 19140 | RSS: Main: 281755648 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | __start_tp_report 05:33:48 INFO - PROCESS | 19140 | _x_x_mozilla_page_load 05:33:48 INFO - PROCESS | 19140 | _x_x_mozilla_page_load_details 05:33:48 INFO - PROCESS | 19140 | |i|pagename|runs| 05:33:48 INFO - PROCESS | 19140 | |0;ai-astar;101;113;112;111;110;112;111;110;109;110 05:33:48 INFO - PROCESS | 19140 | |1;audio-beat-detection;150;125;135;179;127;127;150;126;179;124 05:33:48 INFO - PROCESS | 19140 | |2;audio-dft;162;160;161;160;160;160;161;160;161;162 05:33:48 INFO - PROCESS | 19140 | |3;audio-fft;75;75;75;130;76;76;74;74;105;75 05:33:48 INFO - PROCESS | 19140 | |4;audio-oscillator;85;85;115;85;86;86;116;85;85;132 05:33:48 INFO - PROCESS | 19140 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 05:33:48 INFO - PROCESS | 19140 | |6;imaging-darkroom;145;146;145;146;146;146;146;146;146;146 05:33:48 INFO - PROCESS | 19140 | |7;imaging-desaturate;95;96;96;95;96;95;96;95;95;95 05:33:48 INFO - PROCESS | 19140 | |8;json-parse-financial;53;53;52;55;52;54;52;53;53;53 05:33:48 INFO - PROCESS | 19140 | |9;json-stringify-tinderbox;61;61;62;62;63;62;62;62;61;61 05:33:48 INFO - PROCESS | 19140 | |10;stanford-crypto-aes;81;82;78;82;79;80;79;79;88;79 05:33:48 INFO - PROCESS | 19140 | |11;stanford-crypto-ccm;125;142;128;128;119;119;126;132;144;131 05:33:48 INFO - PROCESS | 19140 | |12;stanford-crypto-pbkdf2;167;165;168;157;157;160;158;157;159;163 05:33:48 INFO - PROCESS | 19140 | |13;stanford-crypto-sha256-iterative;62;62;65;62;62;62;65;65;61;68 05:33:48 INFO - PROCESS | 19140 | __end_tp_report 05:33:48 INFO - PROCESS | 19140 | __start_cc_report 05:33:48 INFO - PROCESS | 19140 | _x_x_mozilla_cycle_collect,1640 05:33:48 INFO - PROCESS | 19140 | __end_cc_report 05:33:48 INFO - PROCESS | 19140 | __startTimestamp1466685228459__endTimestamp 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | ------- Summary: start ------- 05:33:48 INFO - PROCESS | 19140 | Number of tests: 14 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:1.27 05:33:48 INFO - PROCESS | 19140 | Values: 101.0 113.0 112.0 111.0 110.0 112.0 111.0 110.0 109.0 110.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:142.50 stddev:21.69 (15.2%) stddev-sans-first:22.82 05:33:48 INFO - PROCESS | 19140 | Values: 150.0 125.0 135.0 179.0 127.0 127.0 150.0 126.0 179.0 124.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 05:33:48 INFO - PROCESS | 19140 | Values: 162.0 160.0 161.0 160.0 160.0 160.0 161.0 160.0 161.0 162.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:18.88 (25.2%) stddev-sans-first:19.77 05:33:48 INFO - PROCESS | 19140 | Values: 75.0 75.0 75.0 130.0 76.0 76.0 74.0 74.0 105.0 75.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.83 (21.0%) stddev-sans-first:18.46 05:33:48 INFO - PROCESS | 19140 | Values: 85.0 85.0 115.0 85.0 86.0 86.0 116.0 85.0 85.0 132.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:33:48 INFO - PROCESS | 19140 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 05:33:48 INFO - PROCESS | 19140 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:33:48 INFO - PROCESS | 19140 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 05:33:48 INFO - PROCESS | 19140 | Values: 53.0 53.0 52.0 55.0 52.0 54.0 52.0 53.0 53.0 53.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 05:33:48 INFO - PROCESS | 19140 | Values: 61.0 61.0 62.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.91 (3.6%) stddev-sans-first:3.08 05:33:48 INFO - PROCESS | 19140 | Values: 81.0 82.0 78.0 82.0 79.0 80.0 79.0 79.0 88.0 79.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:129.50 stddev:8.38 (6.5%) stddev-sans-first:8.74 05:33:48 INFO - PROCESS | 19140 | Values: 125.0 142.0 128.0 128.0 119.0 119.0 126.0 132.0 144.0 131.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:4.31 (2.7%) stddev-sans-first:4.00 05:33:48 INFO - PROCESS | 19140 | Values: 167.0 165.0 168.0 157.0 157.0 160.0 158.0 157.0 159.0 163.0 05:33:48 INFO - PROCESS | 19140 | 05:33:48 INFO - PROCESS | 19140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.22 (3.5%) stddev-sans-first:2.30 05:33:48 INFO - PROCESS | 19140 | Values: 62.0 62.0 65.0 62.0 62.0 62.0 65.0 65.0 61.0 68.0 05:33:48 INFO - PROCESS | 19140 | -------- Summary: end -------- 05:33:48 INFO - PROCESS | 19140 | 05:33:49 INFO - TEST-INFO | 19140: exit 0 05:33:49 INFO - TEST-OK | kraken | took 61593ms 05:33:49 INFO - SUITE-END | took 1175s 05:33:49 INFO - Completed test suite (00:19:35) 05:33:49 INFO - javascript benchmark 05:33:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.0, 3060.831654259015, 3072.6466456357525, 3084.367704620552, 3131.1858916681654, 5145.794168233266, 5189.040027594893, 5234.953009398117, 5316.20256961456, 5333.3866605340345, 5218.660787048839, 5252.763625636846, 5304.602154838393, 5361.115415956372, 5372.7313634318325, 4759.833405830788, 4794.9520504794855, 4797.208460603996, 4875.512448755132, 4984.22744474607, 4831.154547954094, 4900.460949295592, 4954.7522623868845, 4957.5786058185095, 4997.875053123665, 4774.069056533977, 4816.903661926777, 4831.9275210871865, 4848.927266091011, 4849.054434385296, 4869.2939523768855, 4871.853844384674, 4875.122477953967, 4877.975610121962, 4881.975590122062, 4681.32120842476, 4715.3634259374885, 4840.636952228597, 4845.927311090337, 4847.733374664392, 5204.687718736888, 5211.635185537014, 5267.236250743659, 5309.389420216686, 5319.867003324909, 5653.321601407816, 5657.8585535361535, 5662.631928924607, 5664.8867022659315, 5666.744996475169, 5509.146082357241, 5565.5825813063775, 5594.776208951637, 5602.215689803431, 5609.831705048855, 5257.106291930381, 5290.867728306785, 5292.947070529284, 5316.494932981361, 5319.46805319465, 5622.550195984311, 5753.568482363756, 5756.94243057564, 5757.0788673811985, 5764.596478246483, 5483.945160548423, 5529.668219906818, 5544.77820887168, 5547.25112109868, 5604.019296623074, 5642.633228840113, 5646.322441307069, 5680.545556355564, 5684.971575142098, 5701.2588363513305, 5423.566114710814, 5480.013597552399, 5641.294838145232, 5645.5483561314995, 5654.208410822488, 5537.36320323168, 5572.944270557243, 5575.498205161555, 5581.190727344512, 5592.832215033555, 4283.100548884707, 4285.742855428684, 4288.678349123828, 4289.742615443021, 4325.740455572675, 3824.9808750956067, 3833.6933045356304, 3846.480725102131, 3882.378819388884, 3889.2610404023144, 5339.813106541253, 5361.597880158925, 5361.812336568201, 5363.812266570651, 5400.459954004568, 5635.408282130399, 5638.605297629127, 5638.802641907513, 5651.689157096399, 5696.060150075274, 5178.922316165261, 5225.947740522623, 5315.521603055744, 5328.573714102862, 5355.785768569292, 4870.4155501340065, 4878.82924097662, 4901.460839307673, 4910.165271903785, 4948.950510494849, 5778.456170955091, 5793.855153621109, 5824.825255242349, 5830.4461076197695, 5831.212786273799, 5471.2887324647545, 5608.85977850557, 5667.773289068391, 5674.517665998436, 5677.801276955287, 5833.270841144857, 5836.912446313224, 5845.269341332333, 5853.268341457318, 5861.472467477947, 5436.619436639556, 5566.582506311962, 5567.5545956322585, 5571.8885622288135, 5573.247611572548, 5568.470995255444, 5636.267285252891, 5660.235868157746, 5701.287339082614, 5704.857378565569, 5476.452354764491, 5480.040992826319, 5485.50630443262, 5486.177073439016, 5487.149491828773, 5408.675479471244, 5426.565874730091, 5460.808871689472, 5468.507834294774, 5508.44915508446, 5328.0, 5419.701916394636, 5434.184872269033, 5438.428964958781, 5483.177523371526, 5540.556755459473, 5540.584456165723, 5601.971990140023, 5604.85987850307, 5606.607537472338, 5265.447128051499, 5317.627766056494, 5334.333208348957, 5424.294841670716, 5429.375621803543], "value": 5200.496242380147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2798585725416, 601.3925934805847, 621.0559948877706, 632.1150389454763, 641.8748344072908, 31078.37843243134, 31629.051128466126, 43028.99999999996, 43659.563404365945, 43702.344464832975, 41129.794351028206, 45256.32115518262, 45272.32091518622, 45352.77323613386, 45415.31877021839, 8874.95562522188, 9022.54887255638, 9026.593803278869, 9027.187553120219, 9029.503377314246, 8870.822583548324, 8899.777505562348, 8967.372283940127, 8980.775480613005, 8991.0, 9002.189802917736, 9076.8638470423, 9110.77223069422, 9116.27069834415, 9121.771955701128, 8988.77528061797, 9018.503982280972, 9030.051844556292, 9037.141471560224, 9041.593128309176, 8871.733847984571, 8913.420627659181, 8932.8660070099, 8938.553072346422, 8939.0, 42761.572384276384, 42812.35781463281, 43153.568464315584, 43183.35224971628, 43184.13631727379, 3577.141486043357, 3624.619414961444, 3727.0, 3734.719896007783, 3774.3960966245268, 31385.686143138504, 33658.679106066695, 34428.65571344305, 34833.12917177091, 35443.64556354455, 4523.208438523278, 4623.8150473981, 4639.953600463986, 4666.463356713987, 4669.88325291867, 371597.0, 377688.0, 379384.1030794856, 380805.0, 382579.0, 61830.381696183365, 63742.6812865942, 63991.680041599495, 65372.67313663496, 66243.0, 61541.69229153825, 66391.0, 66553.33446665568, 66617.33382666208, 74954.0, 16752.162391880356, 16813.91593042027, 16814.15929203535, 16840.74738878918, 16844.578885527713, 13857.30713464343, 14114.082584631966, 14179.078359906573, 14213.076150050421, 14215.715685686228, 20721.171153154006, 21093.894530527556, 21189.258375957077, 21265.68101478479, 21391.358259252247, 6419.775307864203, 7615.581143037075, 7756.0, 7817.3030304544845, 7863.37093032556, 1000.799840031982, 1019.0522813783105, 1047.8847326794198, 1160.3386069940223, 1164.6268262673607, 32598.185045374055, 33084.0, 33291.500627490605, 33546.61107814158, 33742.0, 1108.41808050774, 1123.601121601836, 1176.1884299833089, 1209.2140108929266, 1255.1151438236204, 16690.248938797784, 17398.65202695939, 17417.100008475878, 17498.825011749974, 17547.575046201437, 605212.0, 610046.0, 610827.0, 611574.0, 613049.0, 60890.69554652199, 60941.08588371178, 61021.694891526146, 61290.0, 61443.6927815367, 1227.2820400066062, 1345.5290648273221, 1351.4459071780523, 1356.409961666678, 1365.3719289127114, 32737.50893736548, 34179.658203417646, 34372.65627343795, 34391.48412773861, 34671.479927800596, 45727.0, 46076.30885536653, 46223.0, 46326.0, 46384.0, 422519.0, 423466.0, 424014.0, 424523.0, 424673.0, 28599.28501787472, 29480.2311861289, 29615.703842961295, 31091.222719432197, 45596.77201614103, 50182.2472662903, 50344.0, 50673.74663126661, 50691.74654126706, 51461.22808157955, 42962.78518607387, 43664.0, 43674.563254368324, 44300.0, 44771.32843007292, 41323.1735365297, 41325.79337103295, 41601.791991041064, 42147.0, 42322.576774231864, 41859.58140418557, 42474.0, 42719.35920961126, 42799.57200427956, 45718.542814571425, 35608.82195589005, 38582.035449113995, 38759.418608721455, 38830.611693882696, 38855.61144388633, 28743.137705868856, 29096.01555199032, 29383.412331753672, 29389.26526836846, 29442.26394340073], "value": 20905.072456276215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.77333599840097, 380.31163593895053, 382.800943509375, 395.45427310311766, 404.4136002795947, 17496.562585935342, 18736.718949215774, 19093.42719718407, 19095.52261193471, 19102.331418400358, 17790.199441025154, 18618.813811861877, 19250.0, 19564.706529402036, 19601.411957641292, 5028.094942910275, 5041.193409054552, 5187.118189907725, 5221.79112835488, 5222.869428264305, 5094.592432605401, 5104.6937183768905, 5120.615953803461, 5126.026055049548, 5137.717425541594, 5017.37282839645, 5206.0368831766245, 5219.765110570014, 5227.634065615409, 5231.189165679307, 5085.898282034357, 5149.948500515003, 5163.457836927106, 5197.480251974791, 5206.0368831766245, 4887.462379138292, 5057.912548802025, 5059.038782631288, 5062.519060689266, 5063.341765570489, 13250.138740981805, 13270.469181232738, 13494.392752326168, 13515.121517101357, 13531.985101117456, 2169.2516081951703, 2236.3514580771557, 2297.310806757966, 2407.57867373209, 2545.2237067694346, 9816.95091524545, 9852.458114803683, 10147.441890696009, 10316.071553560216, 10321.071103600712, 1903.9524011899675, 1918.3285849952545, 1919.3378284491966, 1964.803519648038, 1987.592543528573, 77615.0, 78520.0, 78594.60702696507, 78887.0, 83151.58424207901, 10995.945020274847, 11063.336199828036, 11101.500432480558, 11165.385903775208, 11250.324980501033, 15268.541943741706, 15339.463118790789, 15447.227638618024, 15454.768178477332, 15458.072515649097, 8302.335813134934, 8477.98264208299, 8686.782830429163, 8729.476231426008, 8729.519876406732, 8372.874406883902, 8433.831323373499, 8468.872966905377, 8595.828083438297, 8632.827343453097, 4745.098431298043, 4754.263089221176, 4789.090072886141, 4862.222044472867, 4874.5856602188505, 1804.42258477286, 1882.4070417818343, 1934.9033294058563, 1940.9126589303514, 1992.581557872863, 872.7818045488627, 904.8687940248627, 945.8628498867763, 954.737447202025, 996.7707427291764, 18654.720179197324, 19110.530149575454, 19601.803981959998, 19839.900800495907, 20138.295159669633, 968.375397868385, 983.5819776594918, 985.3989066669326, 1012.6658202793208, 1019.2202964731986, 10637.680869573926, 11096.778064438666, 11106.389148596743, 11176.944115279533, 11197.66407007791, 441609.0, 447129.0, 448491.0, 456409.0, 460691.0, 86223.0, 89079.10920890838, 90050.54974725084, 90676.0, 90780.0, 1002.7242508310273, 1007.7631756537354, 1036.362636978268, 1070.7644318249972, 1072.9034386905216, 17233.56916077108, 17292.654146917244, 17299.13504324804, 17433.389831355842, 17663.20515576828, 40048.79975600103, 40585.391219132325, 40748.1850362997, 41897.0, 42183.578164217965, 55506.167407488116, 56745.0, 57713.71143144257, 58255.70872145612, 58389.4161058401, 7548.849023019399, 7685.193054729173, 7703.653335600024, 7873.409494287836, 8304.958475207586, 9591.376560523544, 13501.662458438617, 13597.305217906185, 13668.111572747739, 13988.510402136284, 11943.940280298542, 12006.399680016139, 12143.939280303543, 12158.452869621065, 12205.755884882075, 11648.650540483799, 11733.0, 11824.645260642195, 12047.33739644328, 12176.512939482322, 12001.579944701894, 12121.636350909486, 12182.817257740964, 12278.263304201777, 12415.62753117408, 7863.263164699874, 7865.567393793396, 8117.350611951148, 8121.4721043132, 8238.546879921421, 10880.183986200907, 12111.818322725343, 12185.634430967086, 12263.816042759545, 12293.44679489443], "value": 8911.8859758621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.7822670146074, 1371.5611004478565, 1435.468876515689, 1501.692153108613, 1709.7435384692303, 7685.077790665121, 7937.404694647896, 7946.364290856732, 7948.7217947371855, 8181.590920453983, 7709.845803083935, 7938.6824527019, 8157.959210203955, 8195.59022048898, 8196.262336389724, 1988.3239698502578, 2153.8599991000533, 2175.5105101352187, 2209.0, 2229.1640634761966, 2229.9219527316545, 2234.620114580517, 2236.0385034435185, 2238.2837492002564, 2249.932502024934, 2195.045155357425, 2224.3882932193696, 2260.152442833937, 2262.061244583496, 2265.1392470861133, 1902.628987347461, 2085.113826623679, 2166.71832661753, 2170.1970270999673, 2204.40481070111, 2076.8961551922494, 2078.833693304532, 2086.937391878246, 2098.8111070003774, 2098.842586805996, 8166.918330816675, 8218.589070546508, 8232.753017409488, 8233.34133269343, 8239.340852731768, 4791.6406269529925, 4923.458419573844, 4935.80256789728, 4938.9012219755405, 4946.530079642428, 3152.401043801693, 3218.5494030835466, 3218.6298575663864, 3218.935621287561, 3225.4194245035883, 1031.8710161229847, 1038.5430410619304, 1054.2988912373262, 1055.6199768083484, 1067.5729708116737, 10945.56217751289, 11177.944110279397, 11181.0, 11182.720431989266, 11187.0, 4140.171965606891, 4202.054537729047, 4225.9577404226175, 4278.251306021434, 4319.935200971988, 9484.193843523377, 9494.857577136348, 9500.667476638422, 9503.382280151767, 9567.091126342986, 4856.757162141878, 4859.829905953275, 4868.659193856467, 4869.975650121798, 4874.5856602188505, 3991.560928297885, 4430.955690443118, 4533.297338912474, 4535.455745310518, 4616.722996620214, 3610.6930910872343, 3669.908252293714, 3712.0348709335767, 3743.082944678517, 3756.154865155318, 1082.3884505254507, 1088.4775307852276, 1125.9774804503863, 1142.874283828778, 1143.0455569599312, 790.1387487638386, 898.3127907151035, 902.5983437370438, 913.6482454255159, 913.7761248494162, 5706.828795136153, 5786.074228123564, 5932.970335148297, 5933.970330148408, 5953.970230148908, 923.8660394242797, 931.2875650127658, 934.149923569562, 936.2509992006368, 961.6393852305386, 3947.703922205846, 4116.279651061112, 4121.216968775923, 4123.649489793401, 4130.958690413117, 10057.647982320585, 10333.276670633133, 10365.585376585002, 10462.947685261524, 10475.423851688078, 10336.121429678562, 10346.948265258625, 10369.0, 10373.0, 10381.429021403896, 7409.296116868889, 7771.261730135628, 7886.0, 7907.446478746432, 7914.960425197953, 5723.599348045764, 5799.94200057994, 5861.589688721919, 5914.763409463745, 5940.108983652487, 8623.655053797778, 9457.33798634089, 9495.715128546155, 9567.138957493858, 9599.664011759554, 9014.86477702848, 9061.909380906107, 9084.227840633355, 9102.772430689285, 9110.088991100836, 6674.733010679713, 7128.073350464407, 7225.710971561289, 7300.0, 7483.176850546544, 8029.959850200945, 8046.396520260887, 8121.959390203011, 8127.674893004214, 8129.4715843469985, 7167.964160179375, 7182.497225194186, 7238.384737297178, 7371.189169191277, 7455.813604659927, 7214.206437291999, 7231.5299505531975, 7238.927610723826, 7266.200717920919, 7337.779866604011, 6677.699503522256, 6760.797176084725, 6766.560173588701, 6770.086038384952, 6776.491763117688, 4773.522647735337, 4963.726995015309, 4964.528369804862, 4990.101781679333, 5064.316317297265, 5106.336176297058, 5108.106081435808, 5112.079825631274, 5279.920801187908, 5316.441773613715], "value": 4359.25534266008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.24584883268676, 286.39902942551134, 303.2313086326164, 308.49406972565, 311.0652489269745, 5004.399472063348, 5182.663126896749, 5188.558972487338, 5197.792088316468, 5217.373915130185, 5180.093483640358, 5226.0, 5246.793237555365, 5259.76331065103, 5260.368755749316, 4069.633732964025, 4082.530508991474, 4092.4244165996006, 4105.753654780708, 4110.177964407116, 3851.557070936836, 3902.0635047588657, 4048.412980117881, 4064.6748260139266, 4127.649149822269, 4005.459262999487, 4023.356262997921, 4052.29084910141, 4059.4316795648633, 4060.817263223147, 4028.81870315835, 4036.192761447722, 4047.1096358801015, 4070.450489183952, 4070.7354021988476, 3536.6463353664685, 3623.492711020433, 3625.619309972468, 3630.2376500934834, 3637.4543818427182, 5043.596512279046, 5047.0915235257635, 5068.949310506885, 5079.288899554065, 5082.79668813247, 4579.862604121881, 4589.747563883985, 4592.33411155384, 4593.747343896084, 4599.31010348447, 5139.58883289336, 5397.892042159174, 5399.325084364455, 5417.6478528895495, 5443.0, 3887.786171760552, 3896.5713771485116, 3912.4522566840665, 3912.882613521599, 3921.941170882439, 5559.138333558305, 5566.832995010156, 5694.259746232963, 5706.115552089392, 5727.05503591911, 4098.057446787256, 4098.774567398762, 4099.508059032935, 4100.7334523255895, 4109.0959988802415, 3862.8454861805776, 3986.940195897064, 4023.657989070903, 4045.8988525287104, 4063.227986682521, 4611.584957353787, 4613.546732779164, 4618.838340658061, 4626.190416677068, 4661.160991021581, 5445.965266599413, 5449.0, 5457.808976685877, 5496.340439147328, 5500.559955203574, 1271.5740227023866, 1279.1621487925424, 1379.6206043338161, 1390.4577214886203, 1393.477445957766, 847.9830403391898, 878.4992554244147, 892.6607889002267, 896.1844721303582, 902.6569903436653, 4638.675292729544, 4646.767661616906, 4650.232711602615, 4670.906581868411, 4676.3686902267755, 4894.486078961729, 4928.457869634337, 4936.531029552187, 4937.827176048893, 4952.47998960104, 4622.791974361162, 4658.906821863544, 4685.554872287127, 4711.811527538928, 4721.504242054603, 2766.4190519991025, 2957.9112626621236, 3002.894898678536, 3014.7136022077866, 3015.8793648254264, 5808.3901190375245, 5830.212921255661, 5832.1834943108, 5837.970810145922, 5839.708014599253, 5457.317835270591, 5671.370322993288, 5718.228039214736, 5722.37053924068, 5750.6262092963825, 5721.0, 5766.221560089334, 5786.161006654096, 5798.115612425979, 5802.2747156606265, 5626.43735626434, 5662.631928924607, 5663.32040155184, 5684.602077854676, 5705.087186050212, 5343.438938911514, 5548.306461692288, 5615.438456154352, 5668.801591944262, 5673.744681489426, 5709.486146246858, 5736.569757268305, 5767.163761254678, 5781.93034288658, 5878.353381127987, 3870.5161854768153, 3958.1687845552756, 3964.4053391991433, 3967.1272320089533, 3976.741511801724, 5461.754221060141, 5468.644538105011, 5570.2480165177185, 5597.384287728265, 5605.80379686709, 5397.676139431646, 5413.10683737179, 5466.34403871538, 5501.0648189807025, 5514.862128446821, 5282.234076059027, 5436.477786219864, 5460.453954604508, 5482.17767334903, 5501.257330260363, 5317.707526086102, 5335.359756829205, 5368.489993450616, 5398.379186393615, 5399.163129714901, 5415.6479828811, 5489.725513724377, 5493.121100623881, 5503.174523821459, 5507.394186639386, 5219.399769026611, 5381.11211650089, 5438.809641662523, 5456.372517160418, 5465.890682186255], "value": 4104.448906213063, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2032713197649, 723.2514347650183, 747.8317378589818, 803.7288236875916, 806.7297455352458, 14676.266186690662, 15732.685346293067, 15758.684826303466, 15779.13214773187, 15786.052836829784, 14425.567232983001, 14722.0, 14878.0, 14940.775888361655, 14942.701145977102, 798.1499702816511, 820.5404973214988, 820.659426338069, 826.4545400035978, 828.2876726015621, 798.2137594469443, 803.4456225204619, 803.8914746509234, 807.1565214351017, 808.1595141053327, 857.34413173922, 860.3977215948829, 860.4450129666361, 860.7546849147994, 863.8099618084011, 848.3722045686179, 849.8980122385292, 852.722865068852, 853.2534032721369, 853.7950891785957, 630.867517821258, 633.3223450907531, 633.5470138850744, 633.885900537903, 634.2515831319041, 13414.664633384145, 13450.12574182675, 13506.392212350467, 13508.459661613524, 13531.797023044663, 12897.161684490478, 13112.934435327763, 13184.868151318557, 13235.0, 13343.933280333633, 10782.784344313148, 10888.564457421693, 10896.618618348399, 11082.944585277102, 11087.113030957586, 3785.7539259948016, 3816.3321418751607, 3822.0827001519433, 3851.768893866349, 4040.8181631826346, 49316.75341623305, 51431.22853157168, 75524.24475755282, 76220.23779762187, 78816.60591697063, 11518.654440366803, 11536.826947595793, 11620.535178592761, 11629.825552616718, 12108.939455302843, 18609.162587683586, 18666.440006799818, 18679.439616811516, 18685.532861678566, 18801.247950082117, 8844.115588441104, 8881.156290152425, 9146.314026448043, 9323.347365684336, 9336.813263734688, 4357.9564204358185, 4526.524714904954, 4527.569880861313, 4551.590356867831, 4685.0629874025335, 3305.272839975202, 3412.4198886189406, 3416.4704470807064, 3439.7764145330475, 3443.5351227583956, 598.1954271504819, 608.9543284253699, 612.0452094732232, 627.0938493876305, 634.4163369699887, 614.2904944788687, 685.95541289816, 690.1752405874931, 699.3041923286363, 704.1022696062561, 9391.859122113174, 9397.671081512251, 9415.623375065057, 9732.854007189897, 9821.36161149523, 590.3417689276425, 672.6468603982851, 694.3542505469961, 716.9569825810364, 783.3654739660893, 4623.907521849612, 4880.902381952341, 4893.902121957541, 5036.647434679538, 5115.590752739772, 65939.0, 106299.468502657, 109974.45012774885, 112231.0, 115816.42091789487, 95120.0, 98159.50920245353, 98705.0, 98942.0, 99179.0, 83693.58153209195, 84565.15434845573, 84772.0, 85002.1499785019, 85829.57085214659, 9172.908270917205, 9189.0, 9201.539923003957, 9241.127286448957, 9591.136797688241, 48762.0, 50210.24684629807, 50281.74859125681, 50689.0, 50964.49035509597, 73921.63039184769, 75497.24502754903, 76602.93588256407, 76850.61574692314, 78161.0, 12539.435725392561, 12654.620361389174, 12691.42888570035, 12699.809502857279, 13055.608331750063, 13950.419172453128, 13979.580612581638, 14142.22217778032, 14488.420463181776, 14944.0, 13151.671208219872, 13416.932915335361, 13733.519326823513, 14007.08953917992, 14019.439222430989, 12384.504619815107, 12867.871321286668, 13108.410121544362, 13369.53206637763, 13444.865551344361, 12792.872071279167, 13106.541271055466, 13783.931080344935, 13795.310234488436, 13796.517121900686, 10637.308574942605, 10943.671689849318, 10995.285306455055, 11170.776584468103, 11182.888171118184, 11428.48571814287, 11609.825852612386, 11856.332778569245, 12112.75774484523, 12216.877831221575], "value": 7393.294270349124, "unit": "score"}], "name": "dromaeo_css", "value": 7100.739414146086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 112.0, 111.0, 110.0, 112.0, 111.0, 110.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 135.0, 179.0, 127.0, 127.0, 150.0, 126.0, 179.0, 124.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 130.0, 76.0, 76.0, 74.0, 74.0, 105.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 86.0, 86.0, 116.0, 85.0, 85.0, 132.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 55.0, 52.0, 54.0, 52.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 78.0, 82.0, 79.0, 80.0, 79.0, 79.0, 88.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 142.0, 128.0, 128.0, 119.0, 119.0, 126.0, 132.0, 144.0, 131.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 168.0, 157.0, 157.0, 160.0, 158.0, 157.0, 159.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 62.0, 62.0, 62.0, 65.0, 65.0, 61.0, 68.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1499.7, "alertThreshold": 2.0}]} 05:33:49 INFO - Return code: 0 05:33:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:33:49 INFO - # TBPL SUCCESS # 05:33:49 INFO - Running post-action listener: _resource_record_post_action 05:33:49 INFO - ##### 05:33:49 INFO - ##### Finished run-tests step (success) 05:33:49 INFO - ##### 05:33:49 INFO - Running post-run listener: _resource_record_post_run 05:33:49 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 562728960; Read time: 0; Write time: 557172 05:33:49 INFO - TinderboxPrint: CPU usage
13.2% 05:33:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:33:49 INFO - TinderboxPrint: I/O write bytes / time
562,728,960 / 557,172 05:33:49 INFO - TinderboxPrint: CPU idle
8,270.6 (86.8%) 05:33:49 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 05:33:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:33:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256446464; Read time: 0; Write time: 330672 05:33:49 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293707776; Read time: 0; Write time: 225216 05:33:50 INFO - Running post-run listener: _upload_blobber_files 05:33:50 INFO - Blob upload gear active. 05:33:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:33:50 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:33:50 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:33:50 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:33:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:51 INFO - (blobuploader) - INFO - Done attempting. 05:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:52 INFO - (blobuploader) - INFO - Done attempting. 05:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:56 INFO - (blobuploader) - INFO - Done attempting. 05:33:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:33:56 INFO - Return code: 0 05:33:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:33:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:33:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0892f3b675bef62373d42a56cf7f243e3af5da08dd5040c7417caa01c2e3f8ccbbdc8899545a34f7ab97e82e4c8e8afda399bba7a9c28f0905b8f30ee0739137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b93645e0ab714741e3615bb8c448815350e6e213897a5921e00850316fd3282e23e1307729b4750b95ba5a1227b4204e4ad45eb4779abe385a99bd324b505d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a030b2bb90d0892b2ca84c3dd4f1c675bd868383a46c8165a047e1120ebabddf96756785895b402ac30aae917d26dac1c37fd78bc18516ea228077dcf12adf7f"} 05:33:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:33:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:33:56 INFO - Contents: 05:33:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0892f3b675bef62373d42a56cf7f243e3af5da08dd5040c7417caa01c2e3f8ccbbdc8899545a34f7ab97e82e4c8e8afda399bba7a9c28f0905b8f30ee0739137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b93645e0ab714741e3615bb8c448815350e6e213897a5921e00850316fd3282e23e1307729b4750b95ba5a1227b4204e4ad45eb4779abe385a99bd324b505d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a030b2bb90d0892b2ca84c3dd4f1c675bd868383a46c8165a047e1120ebabddf96756785895b402ac30aae917d26dac1c37fd78bc18516ea228077dcf12adf7f"} 05:33:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:33:56 INFO - Copying logs to upload dir... 05:33:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:33:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.480718 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-23 05:33:56.162889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:33:56.167719) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 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/0892f3b675bef62373d42a56cf7f243e3af5da08dd5040c7417caa01c2e3f8ccbbdc8899545a34f7ab97e82e4c8e8afda399bba7a9c28f0905b8f30ee0739137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b93645e0ab714741e3615bb8c448815350e6e213897a5921e00850316fd3282e23e1307729b4750b95ba5a1227b4204e4ad45eb4779abe385a99bd324b505d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a030b2bb90d0892b2ca84c3dd4f1c675bd868383a46c8165a047e1120ebabddf96756785895b402ac30aae917d26dac1c37fd78bc18516ea228077dcf12adf7f"} build_url:https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/S20JVAvUThyqsLTa1DDPmQ/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/0892f3b675bef62373d42a56cf7f243e3af5da08dd5040c7417caa01c2e3f8ccbbdc8899545a34f7ab97e82e4c8e8afda399bba7a9c28f0905b8f30ee0739137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b93645e0ab714741e3615bb8c448815350e6e213897a5921e00850316fd3282e23e1307729b4750b95ba5a1227b4204e4ad45eb4779abe385a99bd324b505d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a030b2bb90d0892b2ca84c3dd4f1c675bd868383a46c8165a047e1120ebabddf96756785895b402ac30aae917d26dac1c37fd78bc18516ea228077dcf12adf7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:33:56.196405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:33:56.196768) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466683998.135630-1649766128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:33:56.276403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:33:56.276747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:33:56.277067) ========= ========= Total master_lag: 0.19 =========