builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1469611154.25 results: success (0) buildid: 20160726233032 builduid: 8107c640362149089c03c79f66708a92 revision: a878df4314faa5a620aca4b04fbae422f68392d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.246305) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.246773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.247076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.261718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.262026) ========= 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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 02:19:14-- 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% 37.9M=0s 2016-07-27 02:19:14 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.398016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.398302) ========= 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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:14.447511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 02:19:14.447835) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a878df4314faa5a620aca4b04fbae422f68392d3 --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 a878df4314faa5a620aca4b04fbae422f68392d3 --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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 02:19:14,752 truncating revision to first 12 chars 2016-07-27 02:19:14,752 Setting DEBUG logging. 2016-07-27 02:19:14,752 attempt 1/10 2016-07-27 02:19:14,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a878df4314fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 02:19:15,663 unpacking tar archive at: fx-team-a878df4314fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 02:19:15.704110) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:15.704396) ========= script_repo_revision: a878df4314faa5a620aca4b04fbae422f68392d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:15.704773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:15.705060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 02:19:15.712885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-27 02:19:15.713168) ========= /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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:16 INFO - MultiFileLogger online at 20160727 02:19:16 in /builds/slave/test 02:19:16 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 02:19:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:16 INFO - {'append_to_log': False, 02:19:16 INFO - 'base_work_dir': '/builds/slave/test', 02:19:16 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:16 INFO - 'branch': 'Fx-Team', 02:19:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:16 INFO - 'config_files': ('talos/linux_config.py',), 02:19:16 INFO - 'default_actions': ('clobber', 02:19:16 INFO - 'read-buildbot-config', 02:19:16 INFO - 'download-and-extract', 02:19:16 INFO - 'populate-webroot', 02:19:16 INFO - 'create-virtualenv', 02:19:16 INFO - 'install', 02:19:16 INFO - 'run-tests'), 02:19:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:16 INFO - 'download_minidump_stackwalk': True, 02:19:16 INFO - 'download_symbols': 'ondemand', 02:19:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:16 INFO - 'installer_path': 'installer.exe', 02:19:16 INFO - 'log_level': 'info', 02:19:16 INFO - 'log_name': 'talos', 02:19:16 INFO - 'log_to_console': True, 02:19:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:16 INFO - 'opt_config_files': (), 02:19:16 INFO - 'pip_index': False, 02:19:16 INFO - 'sps_profile': False, 02:19:16 INFO - 'sps_profile_interval': 0, 02:19:16 INFO - 'suite': 'dromaeojs', 02:19:16 INFO - 'system_bits': '32', 02:19:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:16 INFO - 'title': 'talos-linux64-ix-063', 02:19:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:16 INFO - 'use_talos_json': True, 02:19:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:16 INFO - 'work_dir': 'build'} 02:19:16 INFO - [mozharness: 2016-07-27 09:19:16.109740Z] Running clobber step. 02:19:16 INFO - Running pre-action listener: _resource_record_pre_action 02:19:16 INFO - Running main action method: clobber 02:19:16 INFO - rmtree: /builds/slave/test/build 02:19:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:17 INFO - Running post-action listener: _resource_record_post_action 02:19:17 INFO - [mozharness: 2016-07-27 09:19:17.097978Z] Finished clobber step (success) 02:19:17 INFO - [mozharness: 2016-07-27 09:19:17.098079Z] Running read-buildbot-config step. 02:19:17 INFO - Running pre-action listener: _resource_record_pre_action 02:19:17 INFO - Running main action method: read_buildbot_config 02:19:17 INFO - Using buildbot properties: 02:19:17 INFO - { 02:19:17 INFO - "project": "", 02:19:17 INFO - "product": "firefox", 02:19:17 INFO - "script_repo_revision": "production", 02:19:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:19:17 INFO - "repository": "", 02:19:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:19:17 INFO - "buildid": "20160726233032", 02:19:17 INFO - "pgo_build": "True", 02:19:17 INFO - "basedir": "/builds/slave/test", 02:19:17 INFO - "buildnumber": 934, 02:19:17 INFO - "slavename": "talos-linux64-ix-063", 02:19:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:19:17 INFO - "platform": "ubuntu64_hw", 02:19:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:19:17 INFO - "branch": "fx-team", 02:19:17 INFO - "repo_path": "integration/fx-team", 02:19:17 INFO - "revision": "a878df4314faa5a620aca4b04fbae422f68392d3", 02:19:17 INFO - "stage_platform": "linux64-pgo", 02:19:17 INFO - "builduid": "8107c640362149089c03c79f66708a92", 02:19:17 INFO - "slavebuilddir": "test" 02:19:17 INFO - } 02:19:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:19:17 INFO - Running post-action listener: _resource_record_post_action 02:19:17 INFO - [mozharness: 2016-07-27 09:19:17.100510Z] Finished read-buildbot-config step (success) 02:19:17 INFO - [mozharness: 2016-07-27 09:19:17.100599Z] Running download-and-extract step. 02:19:17 INFO - Running pre-action listener: _resource_record_pre_action 02:19:17 INFO - Running main action method: download_and_extract 02:19:17 INFO - mkdir: /builds/slave/test/build/tests 02:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:17 INFO - https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:18 INFO - Downloaded 1361 bytes. 02:19:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:18 INFO - Using the following test package requirements: 02:19:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:19:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:19:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'jsshell-linux-x86_64.zip'], 02:19:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:19:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:19:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:19:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:19:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:19:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:18 INFO - https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:19 INFO - Downloaded 24315156 bytes. 02:19:19 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'] 02:19:19 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 02:19:21 INFO - Return code: 0 02:19:21 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 02:19: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')]} 02:19:21 INFO - https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:22 INFO - Downloaded 24315156 bytes. 02:19:22 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'] 02:19:22 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 02:19:23 INFO - Return code: 0 02:19:23 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')]} 02:19:23 INFO - https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:25 INFO - Downloaded 14413725 bytes. 02:19:25 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'] 02:19:25 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 02:19:25 INFO - Return code: 0 02:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:25 INFO - https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:19:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN89OaETRNibIoR1K7PshQ/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 02:19:26 INFO - Downloaded 60943832 bytes. 02:19:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:26 INFO - mkdir: /builds/slave/test/properties 02:19:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:26 INFO - Contents: 02:19:26 INFO - build_url:https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:27 INFO - Running post-action listener: _resource_record_post_action 02:19:27 INFO - Running post-action listener: set_extra_try_arguments 02:19:27 INFO - [mozharness: 2016-07-27 09:19:27.414085Z] Finished download-and-extract step (success) 02:19:27 INFO - [mozharness: 2016-07-27 09:19:27.414321Z] Running populate-webroot step. 02:19:27 INFO - Running pre-action listener: _resource_record_pre_action 02:19:27 INFO - Running main action method: populate_webroot 02:19:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:27 INFO - '--tppagecycles', 02:19:27 INFO - '7'], 02:19:27 INFO - 'tests': ['tsvgm']}}, 02:19:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['damp', 'tps']}, 02:19:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'tests': ['damp', 'tps']}, 02:19:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['dromaeo_dom']}, 02:19:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['basic_compositor_video']}, 02:19:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['a11yr', 02:19:27 INFO - 'ts_paint', 02:19:27 INFO - 'tpaint', 02:19:27 INFO - 'sessionrestore', 02:19:27 INFO - 'sessionrestore_no_auto_restore', 02:19:27 INFO - 'tabpaint']}, 02:19:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['tsvgx', 02:19:27 INFO - 'tsvgr_opacity', 02:19:27 INFO - 'tart', 02:19:27 INFO - 'tscrollx', 02:19:27 INFO - 'cart']}, 02:19:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:27 INFO - 'tsvgr_opacity', 02:19:27 INFO - 'tart', 02:19:27 INFO - 'tscrollx', 02:19:27 INFO - 'cart']}, 02:19:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'talos_options': ['--disable-e10s'], 02:19:27 INFO - 'tests': ['tp5o']}, 02:19:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'tests': ['tp5o']}, 02:19:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'talos_options': ['--disable-e10s', 02:19:27 INFO - '--xperf_path', 02:19:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:27 INFO - 'tests': ['tp5n']}, 02:19:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:27 INFO - 'talos_options': ['--xperf_path', 02:19:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:27 INFO - 'tests': ['tp5n']}}, 02:19:27 INFO - 'talos.zip': {'path': '', 02:19:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:27 INFO - Running post-action listener: _resource_record_post_action 02:19:27 INFO - [mozharness: 2016-07-27 09:19:27.433814Z] Finished populate-webroot step (success) 02:19:27 INFO - [mozharness: 2016-07-27 09:19:27.433903Z] Running create-virtualenv step. 02:19:27 INFO - Running pre-action listener: _resource_record_pre_action 02:19:27 INFO - Running main action method: create_virtualenv 02:19:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:27 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 02:19:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:27 INFO - Using real prefix '/usr' 02:19:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:30 INFO - Installing pip.................done. 02:19:30 INFO - Return code: 0 02:19:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:30 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:30 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 02:19:30 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 02:19:30 INFO - Using env: {'DISPLAY': ':0', 02:19:30 INFO - 'HOME': '/home/cltbld', 02:19:30 INFO - 'LANG': 'en_US.UTF-8', 02:19:30 INFO - 'LANGUAGE': 'en_US:en', 02:19:30 INFO - 'LOGNAME': 'cltbld', 02:19:30 INFO - 'MAIL': '/var/mail/cltbld', 02:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:30 INFO - 'MOZ_NO_REMOTE': '1', 02:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:30 INFO - 'NO_EM_RESTART': '1', 02:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:30 INFO - 'PWD': '/builds/slave/test', 02:19:30 INFO - 'SHELL': '/bin/bash', 02:19:30 INFO - 'SHLVL': '1', 02:19:30 INFO - 'TERM': 'linux', 02:19:30 INFO - 'TMOUT': '86400', 02:19:30 INFO - 'USER': 'cltbld', 02:19:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:30 INFO - '_': '/tools/buildbot/bin/python'} 02:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:30 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 02:19:30 INFO - Cleaning up... 02:19:30 INFO - Return code: 0 02:19:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:30 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:30 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 02:19:30 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 02:19:30 INFO - Using env: {'DISPLAY': ':0', 02:19:30 INFO - 'HOME': '/home/cltbld', 02:19:30 INFO - 'LANG': 'en_US.UTF-8', 02:19:30 INFO - 'LANGUAGE': 'en_US:en', 02:19:30 INFO - 'LOGNAME': 'cltbld', 02:19:30 INFO - 'MAIL': '/var/mail/cltbld', 02:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:30 INFO - 'MOZ_NO_REMOTE': '1', 02:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:30 INFO - 'NO_EM_RESTART': '1', 02:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:30 INFO - 'PWD': '/builds/slave/test', 02:19:30 INFO - 'SHELL': '/bin/bash', 02:19:30 INFO - 'SHLVL': '1', 02:19:30 INFO - 'TERM': 'linux', 02:19:30 INFO - 'TMOUT': '86400', 02:19:30 INFO - 'USER': 'cltbld', 02:19:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:30 INFO - '_': '/tools/buildbot/bin/python'} 02:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:30 INFO - Downloading/unpacking psutil>=3.1.1 02:19:30 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 02:19:30 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 02:19:30 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 02:19:30 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 02:19:30 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 02:19:30 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 02:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:32 INFO - Installing collected packages: psutil 02:19:32 INFO - Running setup.py install for psutil 02:19:32 INFO - building 'psutil._psutil_linux' extension 02:19:32 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 02:19:32 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 02:19:32 INFO - building 'psutil._psutil_posix' extension 02:19:32 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 02:19:32 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 02:19:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:32 INFO - Successfully installed psutil 02:19:32 INFO - Cleaning up... 02:19:33 INFO - Return code: 0 02:19:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:19: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 mozsystemmonitor==0.3 02:19:33 INFO - Using env: {'DISPLAY': ':0', 02:19:33 INFO - 'HOME': '/home/cltbld', 02:19:33 INFO - 'LANG': 'en_US.UTF-8', 02:19:33 INFO - 'LANGUAGE': 'en_US:en', 02:19:33 INFO - 'LOGNAME': 'cltbld', 02:19:33 INFO - 'MAIL': '/var/mail/cltbld', 02:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:33 INFO - 'MOZ_NO_REMOTE': '1', 02:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:33 INFO - 'NO_EM_RESTART': '1', 02:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:33 INFO - 'PWD': '/builds/slave/test', 02:19:33 INFO - 'SHELL': '/bin/bash', 02:19:33 INFO - 'SHLVL': '1', 02:19:33 INFO - 'TERM': 'linux', 02:19:33 INFO - 'TMOUT': '86400', 02:19:33 INFO - 'USER': 'cltbld', 02:19:33 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:33 INFO - '_': '/tools/buildbot/bin/python'} 02:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:35 INFO - Installing collected packages: mozsystemmonitor 02:19:35 INFO - Running setup.py install for mozsystemmonitor 02:19:35 INFO - Successfully installed mozsystemmonitor 02:19:35 INFO - Cleaning up... 02:19:35 INFO - Return code: 0 02:19:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:35 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')]} 02:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:35 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')]} 02:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:35 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:35 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 02:19:35 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 02:19:35 INFO - Using env: {'DISPLAY': ':0', 02:19:35 INFO - 'HOME': '/home/cltbld', 02:19:35 INFO - 'LANG': 'en_US.UTF-8', 02:19:35 INFO - 'LANGUAGE': 'en_US:en', 02:19:35 INFO - 'LOGNAME': 'cltbld', 02:19:35 INFO - 'MAIL': '/var/mail/cltbld', 02:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:35 INFO - 'MOZ_NO_REMOTE': '1', 02:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:35 INFO - 'NO_EM_RESTART': '1', 02:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:35 INFO - 'PWD': '/builds/slave/test', 02:19:35 INFO - 'SHELL': '/bin/bash', 02:19:35 INFO - 'SHLVL': '1', 02:19:35 INFO - 'TERM': 'linux', 02:19:35 INFO - 'TMOUT': '86400', 02:19:35 INFO - 'USER': 'cltbld', 02:19:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:35 INFO - '_': '/tools/buildbot/bin/python'} 02:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:37 INFO - warning: no files found matching '*.txt' 02:19:37 INFO - no previously-included directories found matching 'build' 02:19:37 INFO - no previously-included directories found matching 'dist' 02:19:37 INFO - no previously-included directories found matching '.git*' 02:19:37 INFO - Installing collected packages: jsonschema, functools32 02:19:37 INFO - Running setup.py install for functools32 02:19:37 INFO - warning: no files found matching '*.txt' 02:19:37 INFO - no previously-included directories found matching 'build' 02:19:37 INFO - no previously-included directories found matching 'dist' 02:19:37 INFO - no previously-included directories found matching '.git*' 02:19:37 INFO - Successfully installed jsonschema functools32 02:19:37 INFO - Cleaning up... 02:19:37 INFO - Return code: 0 02:19:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:19:37 INFO - Using env: {'DISPLAY': ':0', 02:19:37 INFO - 'HOME': '/home/cltbld', 02:19:37 INFO - 'LANG': 'en_US.UTF-8', 02:19:37 INFO - 'LANGUAGE': 'en_US:en', 02:19:37 INFO - 'LOGNAME': 'cltbld', 02:19:37 INFO - 'MAIL': '/var/mail/cltbld', 02:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:37 INFO - 'MOZ_NO_REMOTE': '1', 02:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:37 INFO - 'NO_EM_RESTART': '1', 02:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:37 INFO - 'PWD': '/builds/slave/test', 02:19:37 INFO - 'SHELL': '/bin/bash', 02:19:37 INFO - 'SHLVL': '1', 02:19:37 INFO - 'TERM': 'linux', 02:19:37 INFO - 'TMOUT': '86400', 02:19:37 INFO - 'USER': 'cltbld', 02:19:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:37 INFO - '_': '/tools/buildbot/bin/python'} 02:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:19:38 INFO - Cleaning up... 02:19:38 INFO - Return code: 0 02:19:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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', '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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:19: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 blobuploader==1.2.4 02:19:38 INFO - Using env: {'DISPLAY': ':0', 02:19:38 INFO - 'HOME': '/home/cltbld', 02:19:38 INFO - 'LANG': 'en_US.UTF-8', 02:19:38 INFO - 'LANGUAGE': 'en_US:en', 02:19:38 INFO - 'LOGNAME': 'cltbld', 02:19:38 INFO - 'MAIL': '/var/mail/cltbld', 02:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:38 INFO - 'MOZ_NO_REMOTE': '1', 02:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:38 INFO - 'NO_EM_RESTART': '1', 02:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:38 INFO - 'PWD': '/builds/slave/test', 02:19:38 INFO - 'SHELL': '/bin/bash', 02:19:38 INFO - 'SHLVL': '1', 02:19:38 INFO - 'TERM': 'linux', 02:19:38 INFO - 'TMOUT': '86400', 02:19:38 INFO - 'USER': 'cltbld', 02:19:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:38 INFO - '_': '/tools/buildbot/bin/python'} 02:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19:40 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19: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 02:19:40 INFO - Downloading docopt-0.6.1.tar.gz 02:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:41 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:41 INFO - Running setup.py install for blobuploader 02:19:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:41 INFO - Running setup.py install for requests 02:19:41 INFO - Running setup.py install for docopt 02:19:41 INFO - Successfully installed blobuploader requests docopt 02:19:41 INFO - Cleaning up... 02:19:41 INFO - Return code: 0 02:19:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:41 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:41 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 02:19:41 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 02:19:41 INFO - Using env: {'DISPLAY': ':0', 02:19:41 INFO - 'HOME': '/home/cltbld', 02:19:41 INFO - 'LANG': 'en_US.UTF-8', 02:19:41 INFO - 'LANGUAGE': 'en_US:en', 02:19:41 INFO - 'LOGNAME': 'cltbld', 02:19:41 INFO - 'MAIL': '/var/mail/cltbld', 02:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:41 INFO - 'MOZ_NO_REMOTE': '1', 02:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:41 INFO - 'NO_EM_RESTART': '1', 02:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:41 INFO - 'PWD': '/builds/slave/test', 02:19:41 INFO - 'SHELL': '/bin/bash', 02:19:41 INFO - 'SHLVL': '1', 02:19:41 INFO - 'TERM': 'linux', 02:19:41 INFO - 'TMOUT': '86400', 02:19:41 INFO - 'USER': 'cltbld', 02:19:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:41 INFO - '_': '/tools/buildbot/bin/python'} 02:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:41 INFO - Running setup.py (path:/tmp/pip-aCddPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:41 INFO - Running setup.py (path:/tmp/pip-384hWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:42 INFO - Running setup.py (path:/tmp/pip-fNI49e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:42 INFO - Running setup.py (path:/tmp/pip-BTKEva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:42 INFO - Running setup.py (path:/tmp/pip-WfJPZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:42 INFO - Running setup.py (path:/tmp/pip-aBTzHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:42 INFO - Running setup.py (path:/tmp/pip-OVY3YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:42 INFO - Running setup.py (path:/tmp/pip-3wrKST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:42 INFO - Running setup.py (path:/tmp/pip-Xrdy6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:42 INFO - Running setup.py (path:/tmp/pip-z0M0Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:42 INFO - Running setup.py (path:/tmp/pip-08rT3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:42 INFO - Running setup.py (path:/tmp/pip-VmwG8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:42 INFO - Running setup.py (path:/tmp/pip-Nz6LPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:42 INFO - Running setup.py (path:/tmp/pip-cA05zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:42 INFO - Running setup.py (path:/tmp/pip-uXZvPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:42 INFO - Running setup.py (path:/tmp/pip-xiUUq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:43 INFO - Running setup.py (path:/tmp/pip-3ph4b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:43 INFO - Running setup.py install for manifestparser 02:19:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Running setup.py install for mozcrash 02:19:43 INFO - Running setup.py install for mozdebug 02:19:43 INFO - Running setup.py install for mozdevice 02:19:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Running setup.py install for mozfile 02:19:43 INFO - Running setup.py install for mozhttpd 02:19:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Running setup.py install for mozinfo 02:19:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Running setup.py install for mozInstall 02:19:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:43 INFO - Running setup.py install for mozleak 02:19:44 INFO - Running setup.py install for mozlog 02:19:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Running setup.py install for moznetwork 02:19:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Running setup.py install for mozprocess 02:19:44 INFO - Running setup.py install for mozprofile 02:19:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Running setup.py install for mozrunner 02:19:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Running setup.py install for mozscreenshot 02:19:44 INFO - Running setup.py install for moztest 02:19:44 INFO - Running setup.py install for mozversion 02:19:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:44 INFO - Cleaning up... 02:19:44 INFO - Return code: 0 02:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:44 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:44 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 02:19:44 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 02:19:44 INFO - Using env: {'DISPLAY': ':0', 02:19:44 INFO - 'HOME': '/home/cltbld', 02:19:44 INFO - 'LANG': 'en_US.UTF-8', 02:19:44 INFO - 'LANGUAGE': 'en_US:en', 02:19:44 INFO - 'LOGNAME': 'cltbld', 02:19:44 INFO - 'MAIL': '/var/mail/cltbld', 02:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:44 INFO - 'MOZ_NO_REMOTE': '1', 02:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:44 INFO - 'NO_EM_RESTART': '1', 02:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:44 INFO - 'PWD': '/builds/slave/test', 02:19:44 INFO - 'SHELL': '/bin/bash', 02:19:44 INFO - 'SHLVL': '1', 02:19:44 INFO - 'TERM': 'linux', 02:19:44 INFO - 'TMOUT': '86400', 02:19:44 INFO - 'USER': 'cltbld', 02:19:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:44 INFO - '_': '/tools/buildbot/bin/python'} 02:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:45 INFO - Running setup.py (path:/tmp/pip-PSelpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:45 INFO - Running setup.py (path:/tmp/pip-UO17wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:45 INFO - Running setup.py (path:/tmp/pip-56H3Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:45 INFO - Running setup.py (path:/tmp/pip-qszxcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:45 INFO - Running setup.py (path:/tmp/pip-vRBlpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:45 INFO - Running setup.py (path:/tmp/pip-Z0Nf1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:45 INFO - Running setup.py (path:/tmp/pip-10AVey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:45 INFO - Running setup.py (path:/tmp/pip-ukN1b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:45 INFO - Running setup.py (path:/tmp/pip-urtJNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:45 INFO - Running setup.py (path:/tmp/pip-gpf8RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:45 INFO - Running setup.py (path:/tmp/pip-Or24xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:45 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)) 02:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:45 INFO - Running setup.py (path:/tmp/pip-3qfFBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:46 INFO - Running setup.py (path:/tmp/pip-_dNWDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:46 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)) 02:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:46 INFO - Running setup.py (path:/tmp/pip-eYwEvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:46 INFO - Running setup.py (path:/tmp/pip-mqk8XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:46 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)) 02:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:46 INFO - Running setup.py (path:/tmp/pip-KlHccJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:46 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)) 02:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:46 INFO - Running setup.py (path:/tmp/pip-_vAVAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:46 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)) 02:19:46 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)) 02:19:46 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)) 02:19:46 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)) 02:19:46 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)) 02:19:46 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)) 02:19:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:48 INFO - Downloading blessings-1.6.tar.gz 02:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:48 INFO - Installing collected packages: blessings 02:19:48 INFO - Running setup.py install for blessings 02:19:48 INFO - Successfully installed blessings 02:19:48 INFO - Cleaning up... 02:19:48 INFO - Return code: 0 02:19:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:48 INFO - Reading from file tmpfile_stdout 02:19:48 INFO - Current package versions: 02:19:48 INFO - argparse == 1.2.1 02:19:48 INFO - blessings == 1.6 02:19:48 INFO - blobuploader == 1.2.4 02:19:48 INFO - docopt == 0.6.1 02:19:48 INFO - functools32 == 3.2.3-2 02:19:48 INFO - jsonschema == 2.5.1 02:19:48 INFO - manifestparser == 1.1 02:19:48 INFO - mozInstall == 1.12 02:19:48 INFO - mozcrash == 0.17 02:19:48 INFO - mozdebug == 0.1 02:19:48 INFO - mozdevice == 0.48 02:19:48 INFO - mozfile == 1.2 02:19:48 INFO - mozhttpd == 0.7 02:19:48 INFO - mozinfo == 0.9 02:19:48 INFO - mozleak == 0.1 02:19:48 INFO - mozlog == 3.3 02:19:48 INFO - moznetwork == 0.27 02:19:48 INFO - mozprocess == 0.23 02:19:48 INFO - mozprofile == 0.28 02:19:48 INFO - mozrunner == 6.12 02:19:48 INFO - mozscreenshot == 0.1 02:19:48 INFO - mozsystemmonitor == 0.3 02:19:48 INFO - moztest == 0.7 02:19:48 INFO - mozversion == 1.4 02:19:48 INFO - psutil == 3.1.1 02:19:48 INFO - requests == 1.2.3 02:19:48 INFO - wsgiref == 0.1.2 02:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 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 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:48 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 02:19:48 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 02:19:48 INFO - Using env: {'DISPLAY': ':0', 02:19:48 INFO - 'HOME': '/home/cltbld', 02:19:48 INFO - 'LANG': 'en_US.UTF-8', 02:19:48 INFO - 'LANGUAGE': 'en_US:en', 02:19:48 INFO - 'LOGNAME': 'cltbld', 02:19:48 INFO - 'MAIL': '/var/mail/cltbld', 02:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:48 INFO - 'MOZ_NO_REMOTE': '1', 02:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:48 INFO - 'NO_EM_RESTART': '1', 02:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:48 INFO - 'PWD': '/builds/slave/test', 02:19:48 INFO - 'SHELL': '/bin/bash', 02:19:48 INFO - 'SHLVL': '1', 02:19:48 INFO - 'TERM': 'linux', 02:19:48 INFO - 'TMOUT': '86400', 02:19:48 INFO - 'USER': 'cltbld', 02:19:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:48 INFO - '_': '/tools/buildbot/bin/python'} 02:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 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)) 02:19:48 INFO - Cleaning up... 02:19:48 INFO - Return code: 0 02:19:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, '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': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', '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 02:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:19:48 INFO - Using env: {'DISPLAY': ':0', 02:19:48 INFO - 'HOME': '/home/cltbld', 02:19:48 INFO - 'LANG': 'en_US.UTF-8', 02:19:48 INFO - 'LANGUAGE': 'en_US:en', 02:19:48 INFO - 'LOGNAME': 'cltbld', 02:19:48 INFO - 'MAIL': '/var/mail/cltbld', 02:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:48 INFO - 'MOZ_NO_REMOTE': '1', 02:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:48 INFO - 'NO_EM_RESTART': '1', 02:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:48 INFO - 'PWD': '/builds/slave/test', 02:19:48 INFO - 'SHELL': '/bin/bash', 02:19:48 INFO - 'SHLVL': '1', 02:19:48 INFO - 'TERM': 'linux', 02:19:48 INFO - 'TMOUT': '86400', 02:19:48 INFO - 'USER': 'cltbld', 02:19:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:48 INFO - '_': '/tools/buildbot/bin/python'} 02:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:49 INFO - Cleaning up... 02:19:49 INFO - Return code: 0 02:19:49 INFO - Running post-action listener: _resource_record_post_action 02:19:49 INFO - Running post-action listener: _start_resource_monitoring 02:19:49 INFO - Starting resource monitoring. 02:19:49 INFO - [mozharness: 2016-07-27 09:19:49.197389Z] Finished create-virtualenv step (success) 02:19:49 INFO - [mozharness: 2016-07-27 09:19:49.197829Z] Running install step. 02:19:49 INFO - Running pre-action listener: _resource_record_pre_action 02:19:49 INFO - Running main action method: install 02:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:49 INFO - Reading from file tmpfile_stdout 02:19:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:49 INFO - Reading from file tmpfile_stdout 02:19:49 INFO - Output received: 02:19:49 INFO - Usage: mozinstall [options] installer 02:19:49 INFO - Options: 02:19:49 INFO - -h, --help show this help message and exit 02:19:49 INFO - -d DEST, --destination=DEST 02:19:49 INFO - Directory to install application into. [default: 02:19:49 INFO - "/builds/slave/test"] 02:19:49 INFO - --app=APP Application being installed. [default: firefox] 02:19:49 INFO - mkdir: /builds/slave/test/build/application 02:19:49 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'] 02:19:49 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 02:20:17 INFO - Reading from file tmpfile_stdout 02:20:17 INFO - Output received: 02:20:17 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:17 INFO - Running post-action listener: _resource_record_post_action 02:20:17 INFO - [mozharness: 2016-07-27 09:20:17.645270Z] Finished install step (success) 02:20:17 INFO - [mozharness: 2016-07-27 09:20:17.645524Z] Running run-tests step. 02:20:17 INFO - Running pre-action listener: _resource_record_pre_action 02:20:17 INFO - Running main action method: run_tests 02:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:17 INFO - Python 2.7.3 02:20:17 INFO - Return code: 0 02:20:17 INFO - grabbing minidump binary from tooltool 02:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:17 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 0x1fed3b0>, '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 0x1fee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fee740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:17 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 02:20:17 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 02:20:17 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 02:20:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:19 INFO - Return code: 0 02:20:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:19 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/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:20:19 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/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 02:20:19 INFO - Using env: {'DISPLAY': ':0', 02:20:19 INFO - 'HOME': '/home/cltbld', 02:20:19 INFO - 'LANG': 'en_US.UTF-8', 02:20:19 INFO - 'LANGUAGE': 'en_US:en', 02:20:19 INFO - 'LOGNAME': 'cltbld', 02:20:19 INFO - 'MAIL': '/var/mail/cltbld', 02:20:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:19 INFO - 'MOZ_NO_REMOTE': '1', 02:20:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:19 INFO - 'NO_EM_RESTART': '1', 02:20:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:19 INFO - 'PWD': '/builds/slave/test', 02:20:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:19 INFO - 'SHELL': '/bin/bash', 02:20:19 INFO - 'SHLVL': '1', 02:20:19 INFO - 'TERM': 'linux', 02:20:19 INFO - 'TMOUT': '86400', 02:20:19 INFO - 'USER': 'cltbld', 02:20:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152', 02:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:19 INFO - '_': '/tools/buildbot/bin/python'} 02:20:19 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/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:20:19 INFO - mozversion application_buildid: 20160726233032 02:20:19 INFO - mozversion application_changeset: a878df4314faa5a620aca4b04fbae422f68392d3 02:20:19 INFO - mozversion application_display_name: Nightly 02:20:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:19 INFO - mozversion application_name: Firefox 02:20:19 INFO - mozversion application_remotingname: firefox 02:20:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:19 INFO - mozversion application_vendor: Mozilla 02:20:19 INFO - mozversion application_version: 50.0a1 02:20:19 INFO - mozversion platform_buildid: 20160726233032 02:20:19 INFO - mozversion platform_changeset: a878df4314faa5a620aca4b04fbae422f68392d3 02:20:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:19 INFO - mozversion platform_version: 50.0a1 02:20:19 INFO - using testdate: 1469611219 02:20:19 INFO - actual date: 1469611219 02:20:19 INFO - starting webserver on 'localhost:37406' 02:20:19 INFO - SUITE-START | Running 2 tests 02:20:19 INFO - TEST-START | dromaeo_css 02:20:19 INFO - operating with platform_type : linux_ 02:20:19 INFO - Initialising browser for dromaeo_css test... 02:20:19 INFO - TEST-INFO | started process 1244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQJmCGZ/profile http://localhost:37406/getInfo.html) 02:20:25 INFO - PROCESS | 1244 | JavaScript error: , line 0: uncaught exception: undefined 02:20:26 INFO - PROCESS | 1244 | __metrics Screen width/height:1600/1200 02:20:26 INFO - PROCESS | 1244 | colorDepth:24 02:20:26 INFO - PROCESS | 1244 | Browser inner width/height: 1024/697 02:20:26 INFO - PROCESS | 1244 | __metrics 02:20:28 INFO - PROCESS | 1244 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:20:28 INFO - PROCESS | 1244 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:29 INFO - PROCESS | 1244 | console.error: PushService: 02:20:29 INFO - PROCESS | 1244 | stateChangeProcessEnqueue: Error transitioning state 02:20:29 INFO - PROCESS | 1244 | UnknownError 02:20:29 INFO - TEST-INFO | 1244: exit 0 02:20:29 INFO - Browser initialized. 02:20:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:29 INFO - TEST-INFO | started process 1323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQJmCGZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:41 INFO - PROCESS | 1323 | RSS: Main: 157519872 02:20:41 INFO - PROCESS | 1323 | 02:21:33 INFO - PROCESS | 1323 | 1469611293225 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] 02:23:41 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37406/tests/dromaeo/cssquery-ext.html) 02:23:42 INFO - PROCESS | 1323 | RSS: Main: 264192000 02:23:42 INFO - PROCESS | 1323 | 02:26:45 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-ext.html (next: http://localhost:37406/tests/dromaeo/cssquery-jquery.html) 02:26:45 INFO - PROCESS | 1323 | RSS: Main: 250109952 02:26:45 INFO - PROCESS | 1323 | 02:29:47 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37406/tests/dromaeo/cssquery-mootools.html) 02:29:48 INFO - PROCESS | 1323 | RSS: Main: 187432960 02:29:48 INFO - PROCESS | 1323 | 02:32:50 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37406/tests/dromaeo/cssquery-prototype.html) 02:32:50 INFO - PROCESS | 1323 | RSS: Main: 225456128 02:32:50 INFO - PROCESS | 1323 | 02:35:53 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37406/tests/dromaeo/cssquery-yui.html) 02:35:54 INFO - PROCESS | 1323 | RSS: Main: 188293120 02:35:54 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | Cycle 1(1): loaded http://localhost:37406/tests/dromaeo/cssquery-yui.html (next: http://localhost:37406/tests/dromaeo/cssquery-dojo.html) 02:38:57 INFO - PROCESS | 1323 | RSS: Main: 274632704 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | __start_tp_report 02:38:57 INFO - PROCESS | 1323 | _x_x_mozilla_page_load 02:38:57 INFO - PROCESS | 1323 | _x_x_mozilla_page_load_details 02:38:57 INFO - PROCESS | 1323 | |i|pagename|runs| 02:38:57 INFO - PROCESS | 1323 | |0;dojo.html;3035.6509001464833;3050.9694903050963;3073.769467289954;3094.644115926669;3105.09952113887;5031.220160875061;5225.843224703265;5349.224362467445;5397.7301134943245;5446.373667028298;5319.148936170213;5323.840284791462;5375.059364611187;5406.324209473816;5420.728963551826;4774.856754297368;4776.665633405663;4939.654224204289;4978.128827455199;4990.201567749143;4968.925466118011;4978.153713868651;4986.077575648516;4986.9750651246695;4988.4762099979525;4790.113828941657;4823.710577365369;4828.46886842447;4945.184044632631;4991.475895031006;4829.879253018667;4855.36880205571;4865.732384718839;4865.9756701216265;4878.560929516325;4833.444153922309;4909.3126962225315;4915.361003069578;4921.335619691332;4932.482089380635;5187.429382767892;5296.602754793367;5423.05096608092;5453.209284653703;5472.26124473195;5687.914681279784;5769.9711501442225;5770.567207459415;5771.711414429304;5772.797952071699;5741.712914354307;5799.420057994209;5811.622244554091;5811.88376232473;5812.854678633068;5180.352455943007;5337.626366154332;5372.382176049726;5420.403755586883;5425.37608175061;5917.881642367129;5972.761089556369;5975.760969561169;5976.760929562855;5983.521318294526;5682.914756278659;5722.4277572242445;5732.914006289909;5733.684647344353;5734.426557344233;5549.5837812164245;5670.716464176775;5766.394528574523;5804.2744656917885;5810.4189581041555;5708.885822283531;5731.312242530923;5754.683492407874;5785.82642520725;5790.478856902899;5711.343195532484;5750.654960702372;5762.1068734346245;5762.9135562966585;5768.826935191951;4282.293421585466;4347.34789781529;4396.648268138541;4401.273789824707;4406.074724307931;3918.529776426847;3935.4490371348033;3965.0682089708894;3989.202159568098;4003.899902502461;5491.258680078218;5494.5054945054335;5503.532199763065;5505.091659876156;5514.696691681916;5566.443355664401;5748.511376532958;5836.241288632451;5841.211436456109;5868.530517558585;5451.073317536028;5514.696691681916;5514.834554963358;5546.168074788733;5554.861128471821;5018.623603229699;5026.572741316956;5028.195488721787;5032.993401319751;5069.087564238399;5658.603897727119;5857.414258574194;6006.699665016732;6018.488428483628;6020.518358531394;5742.770289188553;5786.247787787561;5787.39232380594;5820.097884827858;5839.386864379179;5939.554533409925;5939.990201665641;5949.077892926603;5952;5957.136215248851;5404.83785486436;5579.553635709215;5623.943760562342;5673.602847800615;5677.977963966526;5586.581006424453;5727.799527016535;5733.770649173986;5770.769169233184;5821.09772985188;5608.495235428831;5612.326520817528;5616.971915140398;5617.297837770278;5620.016497113071;5424.593155513273;5475.425080366664;5609.607327487037;5613.663180209037;5615.971920140373;5445.074337362578;5489.64317319373;5494.670319780826;5533.806316778893;5544;5571.916421253765;5578.163275508706;5632.127020311858;5632.605717599892;5633.746481408264;5345.679259244458;5350.3312085989255;5463.48096930791;5465.070937940639;5470.042742520122 02:38:57 INFO - PROCESS | 1323 | |1;ext.html;586.6656006076536;614.7971169514061;623.9064140378943;624.9812505624833;633.9461145802603;31585.68414315856;33763.155921101985;34042.48936265955;34051.65948340516;34064;33760.49359259607;43776.781116094455;44296;44322.11355772883;47929.52070479294;8949.507777072275;9041.457512549236;9083.682071127512;9096.54517274137;9097.818043639123;8242.83514329713;8963.327750418712;9039.728808135766;9046.773830654254;10580.206484513692;10555.472226388689;10901.727456813564;10924.781504369948;10926.344419334826;10944.616938407158;10756.515956781963;10814.134869210444;10817.945910270437;10824.458777061116;10824.837627435594;8037.196280371974;8207.917920820775;10511.054005139498;10573.471326433648;10668.093212076983;38898.80550597229;42932.14135717299;42963.35554966678;43011.35482967758;43028.784856075836;3522.4364101743854;3783.2055268393397;4116.636365452629;4148.23257697324;4328.156009578133;32859.3428131436;33550.83224583886;33600.15999600005;33697.15757106068;33818.6618133818;4389.670774691879;4427.756473393962;4522.3668686383935;4533.546645335473;4618.676692631517;248794;249037;249504;249975;251284.99999999817;57160;57510;57530.42469575335;57669.711651441474;57708.13437798437;53137;53605.463945360825;53615.73192134014;53747.46252537503;53791.731041344545;15918.840811591968;15971.520854374387;16100.677986440205;16101;16178.75731864023;13061.673458163621;13071.281079540717;13143.211407315592;13160.47358105665;13172.143810652276;14222.644433889236;15300.469953004833;15718.449854255046;15731.954845869963;15838.52484425469;5051.4695956924725;5782.59521833476;5812.680302583399;5852.502537284294;5906.734196961147;898.9101089890959;965.666844938495;1120.025577747365;1133.812920868064;1169.859616845984;32122.678773212436;32430;32495.350092998007;32864.50703239453;33122.8343858284;1078.218291738499;1104.4146602300793;1130.2992144870234;1139.7378602921374;1154.4054811771944;16937.91531042337;16980.320787168373;17084.572885677957;17222.655546889244;17286.481405557854;553011;555333;559557;559831;561179;57234.7138264306;57261;57321;57409.71295143497;57538;1317.3939987605809;1349.817774600436;1376.057400680537;1381.2748307138631;1383.0180571793937;30456.629451674286;31990;32009.879654211993;32783.180420489676;33267.33465330728;52138.73930630323;52449.47550524446;52455.73772131115;52574.73712631565;52598;490878;495785.2528848281;496031;499726;500384;41634.79182604189;41844.58155418407;42828;42961;42962;48107.518924810305;48912.26631600458;49034.75482622564;49124.26313605227;49388.75305623449;40347.59652403439;41368.79315603403;41479;42044.36933446062;42851.785741072345;40924.72602191758;41456;41549.792251038554;41902.79048604737;42291.788541057096;40992.1801563973;41282.793586031876;42130;42153.156936860476;42203;33861.830690847375;36599;36870.262594747415;37207;37869.62130378661;28189.81990277298;28294.292642683275;28367.716322836506;28422.87348391634;28485.145445636663 02:38:57 INFO - PROCESS | 1323 | |2;jquery.html;377.1269511081847;385.9266739319531;391.205852120196;395.82979318892865;410.9876703698888;14028.859711402883;15831.525054248377;18459;18903.621927561442;19029;18954;19012;19024.809751902478;19217.711734323962;19237.807621923777;4327.32926396409;5636.351819540764;5812.680302583356;5828.47543721065;5847.619904706181;4813.374261346037;6554.672266386661;6641.203055633331;6723.159605049369;6736.124303840494;6371;6464.256610489807;6507.023946408053;6682.131322928012;6687.765928192514;6311.873762524724;6499;6523.739050438001;6563.868722625544;6566.080748695211;5632.7746890124345;5687.857803554903;5690.943090569082;5691.686957217351;5694.174344720034;23118.42203944898;23570;23708;23757.88121059401;23842.76157238423;2391.426057746146;2450.399652085233;2531.9240422787348;2867.311845157168;3026.803257788237;13949.58151255464;14832.258387080603;14866.925665371713;15086;15170.317335719808;1909.1122627977918;1942.417274817549;2030.5837303352926;2071.357879057482;2077.979220207794;78577.60711196465;79381.60309198475;80043;81354.18645813584;82619;10532.789344213226;10931.508082136323;10979.670609881716;11223.66329010131;11320.26418282809;14808.407663693548;15186.012909160869;15262.31319590621;15281.847181528043;15408.922955385375;7916.960415198002;8080.515169089874;8127.106018337978;8145.837083258301;8169.468984515987;7583.696652133964;7758.9612051939375;7819.84360312802;7860.646270917708;8172.67309307633;4535.160995215896;4560.429946256718;4587.632989360844;4618.56123668251;4854.975725121351;1853.2031226572433;1905.7617797775279;1916.377177417345;1919.7120431935043;1943.89308588029;957.5212393803098;961.5240605670263;977.7408986618552;978.0415193110649;994.1500017485091;19549.315773947845;19898.403047908585;19982.70025949612;20078;20095.59808803845;943.8961714211431;976.3995142987012;977.9975327113899;988.0564061321421;1008.0322890025511;8157.3881958852135;11132.777344453065;11137.665870023913;11149.219554631098;11151.553937842395;469886;470548;483860;488502;490686;90116;90187.54906225558;91662.54168729113;92625.5368723152;93325.5333723327;933.7805615680445;942.3356533643764;961.0485619237045;964.0793042644258;968.9806203875883;15924.124173170587;17357.47927562175;17738.5565360867;17806.554836129202;18208.544786380447;42310.36534452047;42826.78586607047;42851.571484286;43429.13141737211;44099.77950110229;51761.48238517717;53731.462685372644;57077.71461142668;58061;58280;7568.3945284378215;7826.2173782621285;8011.919880801117;8068.636911338886;8178.223068808454;10786.352818830896;12804.423800928795;12877.16298440636;13042.282674452996;13298.135621184592;6193.69932314219;11112.555497780322;11257.437128143723;11624.535018599161;11663.066954643438;11259.493322800658;11488.253263537843;11512.942435288105;11664.825027624762;11670.649880503599;11447.313161210353;11554.76890462203;11705.414729263332;12060.819087713868;12130.93934530357;7984.441089123706;7992.760217193493;8249.133840946613;8299.419040667095;8417.242448179693;10307.690769276935;11462.197646165023;11632.243904146204;11678.88321116778;11996.100292477924 02:38:57 INFO - PROCESS | 1323 | |3;mootools.html;1340.0418700629048;1394.2122700674117;1480.3412481445757;1536.231884057971;1717.0470388934136;8592.65629374825;8925.375223734341;8959.596818143184;9022.323325750562;9025.323100767437;8955.955220223907;9010.053944335848;9043.050479699636;9045.231155351787;9051;2420.165043060141;2444.4133407982135;2448.461338505526;2449.5713250181234;2450.2894160693377;2400.795932345744;2422.9151979680714;2454.8772561371948;2458.7049554053538;2461.3600463879343;2377.2749311459997;2395.5448464791634;2419.7701218384227;2426.1993542131054;2430.2952143878256;2273.5680220758086;2284.4859906521065;2288.599495088361;2296.150424342987;2344.3318654183645;2245.3376254005107;2275.306031660343;2287.885605719707;2288.1305104060516;2296.6555016747457;8744.956275218647;8913.28693704502;8948.865767013434;8967.68613098545;8996.505192214425;5265.578753699695;5499.670019798825;5509.090999984997;5511.173324001432;5521.365043020024;3416.7095796857298;3453.723702103826;3495.2135769451925;3495.5106285120105;3502.562179727534;1111.0611533254387;1165.091228841505;1169.421136537411;1186.35936594239;1190.0836356005827;12501.24992500453;12594;12611.180273282116;12640.936795315965;12671;4337.7397356158735;4494.52807455219;4610.654200934943;4612.630989520831;4681.250999840009;9868.358556693793;9921.50392480373;9927.751806204902;9928.851067233998;9938.155256803253;5189.896202075937;5215.7913683453;5217.973910130501;5220.138677118309;5221.425643179247;4291.527931927485;4861.197902346144;4889.731064791471;5004.3994720633755;5032;3792.810359482015;3841.1741475582885;3922.0783115967724;3924.411338299221;3997.6002399760373;1069.4706120470416;1161.6282789507277;1176.5470293936726;1177.3465726521863;1187.3172925567833;858.3047731337637;904.2178515584104;989.7327721515151;998.8701468809008;1016.539805402401;6031.638101713911;6073.331933487313;6255.655938923312;6274.247090349188;6295.527835412362;978.7797745507346;994.2692121290845;1003.9949800251098;1004.7237009822358;1022.8465730140539;4363.946810675583;4431.911361772811;4472.664550158751;4530.77346132692;4631.58315751584;11075;11107.111431085494;11189.944050279697;11211.990920817165;11215.271007384494;11154.21920465576;11155.49800258974;11155.776884462428;11164.330140191452;11175.664730057948;8227.506349619041;8515.74452766418;8523.744287671256;8603.440776349516;8608.440451370767;6228.688565571794;6235.688215589294;6341.175647165839;6353.968230159005;6457.056133554462;9965.800683986425;10268.897311027093;10281;10332.483375831029;10341.689749307232;10339.793204136025;10342.5345859435;10360.067593916583;10364.015418535228;10373.688789336333;8175.509469431853;8184.54984975832;8187.836243274982;8267.379946504156;8371.079181289932;8889.866652000095;8994.910050899407;9017.549122543978;9018.188363047357;9024.774380640536;7547.358474529727;7789.5715735635085;7793.649285782267;7822.530648161129;7942.64258108375;7931.405144614062;7952.244536768998;8002.879956800536;8073.959630201812;8195.836083278182;6948.965255173692;6961.095057642474;6969.4424446045205;7022.894656580053;7028.051213086168;5236.136037553761;5266.73666316675;5288;5299.046171689133;5352.35771707382;5205.973970130125;5221.373435187802;5266.1574148136115;5288.65623734456;5297.046531624344 02:38:57 INFO - PROCESS | 1323 | |4;prototype.html;330.08401685323224;335.92945481448896;338.8678415417987;342.746367687911;344.22205814858427;5340.652857564261;5352.411234764173;5357.678539287641;5364.812231571896;5395.271638328824;5045.77294021769;5129.9230511542355;5213.244079608455;5219.877726288857;5303.575713942885;4157.168566286739;4163.770992595406;4165.854195103172;4170.728902621335;4170.833166673345;4167.229062623409;4170.04089059515;4177.12280421112;4191.517975432818;4193.35003074524;3880.553736320331;3906.335922893101;4129.958700413003;4140;4166.166766646667;4085.20338533986;4105.91788164238;4127.711060225785;4130.607592278729;4132.2355364257555;3637.236180402119;3645.453182022691;3653.451982202664;3656.341858465475;3671.94492082619;5075.162598171298;5141.562967147759;5157.252198431244;5190.143626301693;5191.428942816287;4709.599684026827;4717.386739723848;4742.359781429497;4743.288506723985;4748.857534273943;5464.836054918359;5464.863378415532;5477.685355514648;5496.642718223303;5523.7238138092935;3923.509561304837;4061.431399604058;4074.409210664437;4078.836846526165;4084.979575102135;5731;5733.913991290134;5738.282714660668;5749.425057494217;5749.942500574983;4199.265128602544;4204.3693445982735;4208.284591619432;4211.073563815956;4217.5782421758195;3988.521377434726;4239.936400953989;4246.363045543131;4256.978715106405;4262.50981137167;4780.705261474512;4782.497837726988;4786.659735274129;4793.688410253322;4799.3041009053495;5577.972110139504;5591.099026331067;5597.384287728347;5604.215409842625;5606.943930560724;1386.932062312014;1452.8692417682248;1468.119128522899;1474.71243107593;1480.9407623695147;950.5342382232657;1010.1010101010107;1030.3354336453096;1034.1003327105466;1039.3763741755038;5315.548178404802;5321.308229930084;5335.706536140472;5349.732513374316;5370.543503802142;5586.692731899703;5601.831945041656;5613.522850557667;5629.155626655953;5647.519960803378;5206.140986737221;5297.602679799031;5306.7611957462;5310.867228319245;5328.37484567203;2975.5982942302944;2983.2243616659825;2989.970100298969;2997.7901546891944;3004.4742170120144;5559.776849093193;5757.625754326039;5772.884542309131;5780;5797.231844287533;5596.272484576979;5617.719114044281;5707.571932105108;5733.741981610838;5749.396313387034;5742.741576628978;5768.221290125864;5777.74000169985;5783.537317014713;5786.363500014911;5459.181122831607;5552.805651802168;5665.376808550974;5758.827235182951;5763.308402991668;5599.524040456444;5611.298587676541;5618.185363122406;5683.8863222736145;5684.971575142098;5695.202671626059;5840.561957853263;5889.823305300848;5889.998700220887;5915.822525324247;3987.72085953992;4020.015096301425;4025;4041.2927737645205;4044.8786536403954;5752.07966725322;5756.194132821324;5768.394318596487;5774.422557744192;5784.392638773036;5474.698891561003;5591.944080559142;5597.692126933058;5617.719114044363;5641.802536911188;5561.582881284001;5567.137093750475;5603.243562119224;5608.579356548194;5610.438956104357;5267.157254839208;5331.626786124934;5506.962423903182;5521.889562208653;5534.529564987021;5588.217649528988;5593.412691667317;5594.727084655359;5600.803971860965;5615.157726341082;5491.32514583056;5493.917591236055;5502.477264659851;5513.558915286687;5515.393306736336 02:38:57 INFO - PROCESS | 1323 | |5;yui.html;805.9032916050074;828.2462958707576;834.9874751878723;859.4714250735791;874.1651722604909;14978;15051.698966020673;15103.77344339833;16379.262933168005;16424.014559126445;16647.50057498277;16865.915670421662;16887.408940687077;16912.83087169128;16933.57666058349;813.0812182234082;825.5129473610568;826.3017750001269;826.6114925984778;827.2224109337234;661.2692974263442;788.5190034079208;798.5408390175672;799.6441583495347;822.0956947357919;856.7943693513542;860.9225169734723;861.130258438978;861.7587075618836;863.3136656358179;853.1425916953453;855.3200205836375;855.7304449098546;856.2764464027887;856.5717141429285;503.48141414343286;598.494272339872;604.8215776345944;610.3865615056884;616.9876602467971;15281.923590381977;15311.693766124616;15320.616984575474;15864.841351586567;15907;14302.427902883976;14320.856791432056;14550.927245363811;14895.47865824691;14921.776173357408;13305.334733263298;13449.462021519128;13513.932430337883;13535.458581656721;14194;4565.201089809303;4640.79116439761;4765.070811191819;4840.080384726926;4845.3216549683075;75434;76009.61995190044;76970;77111;77395.61302193454;12182.573609923611;12322.199057061442;12368.81446778299;12403.503859845685;12865.228086314852;22491;22491.66262506064;22558.548829023326;22657.4335641607;22675;8352.8329433411;8389.916100839035;8506.617202225914;8555.614997325136;8872.06843281459;4794.640401969867;4812.494688057774;4823.2282834746275;4916.72957987307;5064.4935506449065;3566.625504322061;3644.3075815594952;3681.2637472505608;3691.630836916287;3696.537932758405;632.4813652804656;648.3160265919406;651.7393042782925;652.1196384880374;683.6547543490605;555.9833205003856;618.227215980025;687.4156966578369;694.5138403117737;696.345435290825;9032.36773425854;9075.27397808187;9353.345265831327;9671.564779584794;9924.851127233098;560.6075746977132;561.4469747298907;638.9903951756214;647.9244454205996;703.7994171661052;4393.934090988638;4475.48531918827;4699.906001879944;4774.880627984328;4781.928271075936;110148;113445.43277283726;113632.43183784194;116416.41791790987;118050;96975;98877.50561247148;101256.89944804399;101593;102456.48771756093;84845.57577212075;85584;88367.55816220878;89455;90058;8759.562021899006;8771.561421929006;8941.37410381267;8956.68651597191;8977.371583989057;50892.20092894778;51118.48881511137;52541;53512;54195.45804541904;66399;66672.66663666845;69058.65470672614;76021.61989190019;76357.61821190859;13261.602151935458;13644.863551364757;13687;14162.645933851736;14172.291385430894;14631.561053168421;14838.777418338517;14909.552713418614;15050.698986020438;15497.30262138184;13475;14131.505397311044;14348.139111653334;14412.927935360256;14602.926985365006;13308.93345533266;13877.167369957835;13894.722105558034;13941.745242928186;14421.7836732447;13752.65618359549;14509.782353264498;14645.41418343297;15123.16822574769;15156.166410847509;11536.134789890959;11580.768384632429;11813.350265735467;11930.821037684269;11935.462904169506;11676.591319303783;12077.51689932393;12089.335086570323;12186.756264874475;12248 02:38:57 INFO - PROCESS | 1323 | __end_tp_report 02:38:57 INFO - PROCESS | 1323 | __start_cc_report 02:38:57 INFO - PROCESS | 1323 | _x_x_mozilla_cycle_collect,1032 02:38:57 INFO - PROCESS | 1323 | __end_cc_report 02:38:57 INFO - PROCESS | 1323 | __startTimestamp1469612337491__endTimestamp 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | ------- Summary: start ------- 02:38:57 INFO - PROCESS | 1323 | Number of tests: 6 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#0] dojo.html Cycles:165 Average:5340.63 Median:5514.70 stddev:609.42 (11.1%) stddev-sans-first:583.85 02:38:57 INFO - PROCESS | 1323 | Values: 3035.7 3051.0 3073.8 3094.6 3105.1 5031.2 5225.8 5349.2 5397.7 5446.4 5319.1 5323.8 5375.1 5406.3 5420.7 4774.9 4776.7 4939.7 4978.1 4990.2 4968.9 4978.2 4986.1 4987.0 4988.5 4790.1 4823.7 4828.5 4945.2 4991.5 4829.9 4855.4 4865.7 4866.0 4878.6 4833.4 4909.3 4915.4 4921.3 4932.5 5187.4 5296.6 5423.1 5453.2 5472.3 5687.9 5770.0 5770.6 5771.7 5772.8 5741.7 5799.4 5811.6 5811.9 5812.9 5180.4 5337.6 5372.4 5420.4 5425.4 5917.9 5972.8 5975.8 5976.8 5983.5 5682.9 5722.4 5732.9 5733.7 5734.4 5549.6 5670.7 5766.4 5804.3 5810.4 5708.9 5731.3 5754.7 5785.8 5790.5 5711.3 5750.7 5762.1 5762.9 5768.8 4282.3 4347.3 4396.6 4401.3 4406.1 3918.5 3935.4 3965.1 3989.2 4003.9 5491.3 5494.5 5503.5 5505.1 5514.7 5566.4 5748.5 5836.2 5841.2 5868.5 5451.1 5514.7 5514.8 5546.2 5554.9 5018.6 5026.6 5028.2 5033.0 5069.1 5658.6 5857.4 6006.7 6018.5 6020.5 5742.8 5786.2 5787.4 5820.1 5839.4 5939.6 5940.0 5949.1 5952.0 5957.1 5404.8 5579.6 5623.9 5673.6 5678.0 5586.6 5727.8 5733.8 5770.8 5821.1 5608.5 5612.3 5617.0 5617.3 5620.0 5424.6 5475.4 5609.6 5613.7 5616.0 5445.1 5489.6 5494.7 5533.8 5544.0 5571.9 5578.2 5632.1 5632.6 5633.7 5345.7 5350.3 5463.5 5465.1 5470.0 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#1] ext.html Cycles:180 Average:59785.68 Median:41325.79 stddev:121059.42 (292.9%) stddev-sans-first:121317.43 02:38:57 INFO - PROCESS | 1323 | Values: 586.7 614.8 623.9 625.0 633.9 31585.7 33763.2 34042.5 34051.7 34064.0 33760.5 43776.8 44296.0 44322.1 47929.5 8949.5 9041.5 9083.7 9096.5 9097.8 8242.8 8963.3 9039.7 9046.8 10580.2 10555.5 10901.7 10924.8 10926.3 10944.6 10756.5 10814.1 10817.9 10824.5 10824.8 8037.2 8207.9 10511.1 10573.5 10668.1 38898.8 42932.1 42963.4 43011.4 43028.8 3522.4 3783.2 4116.6 4148.2 4328.2 32859.3 33550.8 33600.2 33697.2 33818.7 4389.7 4427.8 4522.4 4533.5 4618.7 248794.0 249037.0 249504.0 249975.0 251285.0 57160.0 57510.0 57530.4 57669.7 57708.1 53137.0 53605.5 53615.7 53747.5 53791.7 15918.8 15971.5 16100.7 16101.0 16178.8 13061.7 13071.3 13143.2 13160.5 13172.1 14222.6 15300.5 15718.4 15732.0 15838.5 5051.5 5782.6 5812.7 5852.5 5906.7 898.9 965.7 1120.0 1133.8 1169.9 32122.7 32430.0 32495.4 32864.5 33122.8 1078.2 1104.4 1130.3 1139.7 1154.4 16937.9 16980.3 17084.6 17222.7 17286.5 553011.0 555333.0 559557.0 559831.0 561179.0 57234.7 57261.0 57321.0 57409.7 57538.0 1317.4 1349.8 1376.1 1381.3 1383.0 30456.6 31990.0 32009.9 32783.2 33267.3 52138.7 52449.5 52455.7 52574.7 52598.0 490878.0 495785.3 496031.0 499726.0 500384.0 41634.8 41844.6 42828.0 42961.0 42962.0 48107.5 48912.3 49034.8 49124.3 49388.8 40347.6 41368.8 41479.0 42044.4 42851.8 40924.7 41456.0 41549.8 41902.8 42291.8 40992.2 41282.8 42130.0 42153.2 42203.0 33861.8 36599.0 36870.3 37207.0 37869.6 28189.8 28294.3 28367.7 28422.9 28485.1 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#2] jquery.html Cycles:180 Average:28750.87 Median:42839.18 stddev:79274.59 (185.1%) stddev-sans-first:79468.35 02:38:57 INFO - PROCESS | 1323 | Values: 377.1 385.9 391.2 395.8 411.0 14028.9 15831.5 18459.0 18903.6 19029.0 18954.0 19012.0 19024.8 19217.7 19237.8 4327.3 5636.4 5812.7 5828.5 5847.6 4813.4 6554.7 6641.2 6723.2 6736.1 6371.0 6464.3 6507.0 6682.1 6687.8 6311.9 6499.0 6523.7 6563.9 6566.1 5632.8 5687.9 5690.9 5691.7 5694.2 23118.4 23570.0 23708.0 23757.9 23842.8 2391.4 2450.4 2531.9 2867.3 3026.8 13949.6 14832.3 14866.9 15086.0 15170.3 1909.1 1942.4 2030.6 2071.4 2078.0 78577.6 79381.6 80043.0 81354.2 82619.0 10532.8 10931.5 10979.7 11223.7 11320.3 14808.4 15186.0 15262.3 15281.8 15408.9 7917.0 8080.5 8127.1 8145.8 8169.5 7583.7 7759.0 7819.8 7860.6 8172.7 4535.2 4560.4 4587.6 4618.6 4855.0 1853.2 1905.8 1916.4 1919.7 1943.9 957.5 961.5 977.7 978.0 994.2 19549.3 19898.4 19982.7 20078.0 20095.6 943.9 976.4 978.0 988.1 1008.0 8157.4 11132.8 11137.7 11149.2 11151.6 469886.0 470548.0 483860.0 488502.0 490686.0 90116.0 90187.5 91662.5 92625.5 93325.5 933.8 942.3 961.0 964.1 969.0 15924.1 17357.5 17738.6 17806.6 18208.5 42310.4 42826.8 42851.6 43429.1 44099.8 51761.5 53731.5 57077.7 58061.0 58280.0 7568.4 7826.2 8011.9 8068.6 8178.2 10786.4 12804.4 12877.2 13042.3 13298.1 6193.7 11112.6 11257.4 11624.5 11663.1 11259.5 11488.3 11512.9 11664.8 11670.6 11447.3 11554.8 11705.4 12060.8 12130.9 7984.4 7992.8 8249.1 8299.4 8417.2 10307.7 11462.2 11632.2 11678.9 11996.1 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#3] mootools.html Cycles:180 Average:5927.10 Median:4947.07 stddev:3367.01 (68.1%) stddev-sans-first:3358.81 02:38:57 INFO - PROCESS | 1323 | Values: 1340.0 1394.2 1480.3 1536.2 1717.0 8592.7 8925.4 8959.6 9022.3 9025.3 8956.0 9010.1 9043.1 9045.2 9051.0 2420.2 2444.4 2448.5 2449.6 2450.3 2400.8 2422.9 2454.9 2458.7 2461.4 2377.3 2395.5 2419.8 2426.2 2430.3 2273.6 2284.5 2288.6 2296.2 2344.3 2245.3 2275.3 2287.9 2288.1 2296.7 8745.0 8913.3 8948.9 8967.7 8996.5 5265.6 5499.7 5509.1 5511.2 5521.4 3416.7 3453.7 3495.2 3495.5 3502.6 1111.1 1165.1 1169.4 1186.4 1190.1 12501.2 12594.0 12611.2 12640.9 12671.0 4337.7 4494.5 4610.7 4612.6 4681.3 9868.4 9921.5 9927.8 9928.9 9938.2 5189.9 5215.8 5218.0 5220.1 5221.4 4291.5 4861.2 4889.7 5004.4 5032.0 3792.8 3841.2 3922.1 3924.4 3997.6 1069.5 1161.6 1176.5 1177.3 1187.3 858.3 904.2 989.7 998.9 1016.5 6031.6 6073.3 6255.7 6274.2 6295.5 978.8 994.3 1004.0 1004.7 1022.8 4363.9 4431.9 4472.7 4530.8 4631.6 11075.0 11107.1 11189.9 11212.0 11215.3 11154.2 11155.5 11155.8 11164.3 11175.7 8227.5 8515.7 8523.7 8603.4 8608.4 6228.7 6235.7 6341.2 6354.0 6457.1 9965.8 10268.9 10281.0 10332.5 10341.7 10339.8 10342.5 10360.1 10364.0 10373.7 8175.5 8184.5 8187.8 8267.4 8371.1 8889.9 8994.9 9017.5 9018.2 9024.8 7547.4 7789.6 7793.6 7822.5 7942.6 7931.4 7952.2 8002.9 8074.0 8195.8 6949.0 6961.1 6969.4 7022.9 7028.1 5236.1 5266.7 5288.0 5299.0 5352.4 5206.0 5221.4 5266.2 5288.7 5297.0 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#4] prototype.html Cycles:180 Average:4680.54 Median:5324.84 stddev:1356.91 (25.5%) stddev-sans-first:1320.84 02:38:57 INFO - PROCESS | 1323 | Values: 330.1 335.9 338.9 342.7 344.2 5340.7 5352.4 5357.7 5364.8 5395.3 5045.8 5129.9 5213.2 5219.9 5303.6 4157.2 4163.8 4165.9 4170.7 4170.8 4167.2 4170.0 4177.1 4191.5 4193.4 3880.6 3906.3 4130.0 4140.0 4166.2 4085.2 4105.9 4127.7 4130.6 4132.2 3637.2 3645.5 3653.5 3656.3 3671.9 5075.2 5141.6 5157.3 5190.1 5191.4 4709.6 4717.4 4742.4 4743.3 4748.9 5464.8 5464.9 5477.7 5496.6 5523.7 3923.5 4061.4 4074.4 4078.8 4085.0 5731.0 5733.9 5738.3 5749.4 5749.9 4199.3 4204.4 4208.3 4211.1 4217.6 3988.5 4239.9 4246.4 4257.0 4262.5 4780.7 4782.5 4786.7 4793.7 4799.3 5578.0 5591.1 5597.4 5604.2 5606.9 1386.9 1452.9 1468.1 1474.7 1480.9 950.5 1010.1 1030.3 1034.1 1039.4 5315.5 5321.3 5335.7 5349.7 5370.5 5586.7 5601.8 5613.5 5629.2 5647.5 5206.1 5297.6 5306.8 5310.9 5328.4 2975.6 2983.2 2990.0 2997.8 3004.5 5559.8 5757.6 5772.9 5780.0 5797.2 5596.3 5617.7 5707.6 5733.7 5749.4 5742.7 5768.2 5777.7 5783.5 5786.4 5459.2 5552.8 5665.4 5758.8 5763.3 5599.5 5611.3 5618.2 5683.9 5685.0 5695.2 5840.6 5889.8 5890.0 5915.8 3987.7 4020.0 4025.0 4041.3 4044.9 5752.1 5756.2 5768.4 5774.4 5784.4 5474.7 5591.9 5597.7 5617.7 5641.8 5561.6 5567.1 5603.2 5608.6 5610.4 5267.2 5331.6 5507.0 5521.9 5534.5 5588.2 5593.4 5594.7 5600.8 5615.2 5491.3 5493.9 5502.5 5513.6 5515.4 02:38:57 INFO - PROCESS | 1323 | 02:38:57 INFO - PROCESS | 1323 | [#5] yui.html Cycles:180 Average:21112.30 Median:4788.28 stddev:29852.70 (623.5%) stddev-sans-first:29897.51 02:38:57 INFO - PROCESS | 1323 | Values: 805.9 828.2 835.0 859.5 874.2 14978.0 15051.7 15103.8 16379.3 16424.0 16647.5 16865.9 16887.4 16912.8 16933.6 813.1 825.5 826.3 826.6 827.2 661.3 788.5 798.5 799.6 822.1 856.8 860.9 861.1 861.8 863.3 853.1 855.3 855.7 856.3 856.6 503.5 598.5 604.8 610.4 617.0 15281.9 15311.7 15320.6 15864.8 15907.0 14302.4 14320.9 14550.9 14895.5 14921.8 13305.3 13449.5 13513.9 13535.5 14194.0 4565.2 4640.8 4765.1 4840.1 4845.3 75434.0 76009.6 76970.0 77111.0 77395.6 12182.6 12322.2 12368.8 12403.5 12865.2 22491.0 22491.7 22558.5 22657.4 22675.0 8352.8 8389.9 8506.6 8555.6 8872.1 4794.6 4812.5 4823.2 4916.7 5064.5 3566.6 3644.3 3681.3 3691.6 3696.5 632.5 648.3 651.7 652.1 683.7 556.0 618.2 687.4 694.5 696.3 9032.4 9075.3 9353.3 9671.6 9924.9 560.6 561.4 639.0 647.9 703.8 4393.9 4475.5 4699.9 4774.9 4781.9 110148.0 113445.4 113632.4 116416.4 118050.0 96975.0 98877.5 101256.9 101593.0 102456.5 84845.6 85584.0 88367.6 89455.0 90058.0 8759.6 8771.6 8941.4 8956.7 8977.4 50892.2 51118.5 52541.0 53512.0 54195.5 66399.0 66672.7 69058.7 76021.6 76357.6 13261.6 13644.9 13687.0 14162.6 14172.3 14631.6 14838.8 14909.6 15050.7 15497.3 13475.0 14131.5 14348.1 14412.9 14602.9 13308.9 13877.2 13894.7 13941.7 14421.8 13752.7 14509.8 14645.4 15123.2 15156.2 11536.1 11580.8 11813.4 11930.8 11935.5 11676.6 12077.5 12089.3 12186.8 12248.0 02:38:57 INFO - PROCESS | 1323 | -------- Summary: end -------- 02:38:57 INFO - PROCESS | 1323 | 02:38:58 INFO - TEST-INFO | 1323: exit 0 02:38:58 INFO - TEST-OK | dromaeo_css | took 1119099ms 02:38:58 INFO - TEST-START | kraken 02:38:58 INFO - operating with platform_type : linux_ 02:38:58 INFO - Initialising browser for kraken test... 02:38:58 INFO - TEST-INFO | started process 1517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCiQlWQ/profile http://localhost:37406/getInfo.html) 02:39:03 INFO - PROCESS | 1517 | JavaScript error: , line 0: uncaught exception: undefined 02:39:04 INFO - PROCESS | 1517 | __metrics Screen width/height:1600/1200 02:39:04 INFO - PROCESS | 1517 | colorDepth:24 02:39:04 INFO - PROCESS | 1517 | Browser inner width/height: 1024/697 02:39:04 INFO - PROCESS | 1517 | __metrics 02:39:06 INFO - PROCESS | 1517 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:39:06 INFO - PROCESS | 1517 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:06 INFO - PROCESS | 1517 | console.error: PushService: 02:39:06 INFO - PROCESS | 1517 | stateChangeProcessEnqueue: Error transitioning state 02:39:06 INFO - PROCESS | 1517 | UnknownError 02:39:07 INFO - TEST-INFO | 1517: exit 0 02:39:07 INFO - Browser initialized. 02:39:07 INFO - Running cycle 1/1 for kraken test... 02:39:07 INFO - TEST-INFO | started process 1598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCiQlWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:19 INFO - PROCESS | 1598 | RSS: Main: 158130176 02:39:19 INFO - PROCESS | 1598 | 02:39:21 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:22 INFO - PROCESS | 1598 | RSS: Main: 213843968 02:39:22 INFO - PROCESS | 1598 | 02:39:25 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-dft) 02:39:25 INFO - PROCESS | 1598 | RSS: Main: 188325888 02:39:25 INFO - PROCESS | 1598 | 02:39:28 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-fft) 02:39:29 INFO - PROCESS | 1598 | RSS: Main: 269856768 02:39:29 INFO - PROCESS | 1598 | 02:39:31 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37406/tests/kraken/driver.html?testName=audio-oscillator) 02:39:32 INFO - PROCESS | 1598 | RSS: Main: 181075968 02:39:32 INFO - PROCESS | 1598 | 02:39:34 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:34 INFO - PROCESS | 1598 | RSS: Main: 185606144 02:39:34 INFO - PROCESS | 1598 | 02:39:37 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:38 INFO - PROCESS | 1598 | RSS: Main: 222121984 02:39:38 INFO - PROCESS | 1598 | 02:39:41 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37406/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:42 INFO - PROCESS | 1598 | RSS: Main: 220921856 02:39:42 INFO - PROCESS | 1598 | 02:39:45 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37406/tests/kraken/driver.html?testName=json-parse-financial) 02:39:45 INFO - PROCESS | 1598 | RSS: Main: 220745728 02:39:45 INFO - PROCESS | 1598 | 02:39:47 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:48 INFO - PROCESS | 1598 | RSS: Main: 185278464 02:39:48 INFO - PROCESS | 1598 | 02:39:49 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:50 INFO - PROCESS | 1598 | RSS: Main: 189722624 02:39:50 INFO - PROCESS | 1598 | 02:39:52 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:53 INFO - PROCESS | 1598 | RSS: Main: 195321856 02:39:53 INFO - PROCESS | 1598 | 02:39:55 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:56 INFO - PROCESS | 1598 | RSS: Main: 190418944 02:39:56 INFO - PROCESS | 1598 | 02:39:58 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:59 INFO - PROCESS | 1598 | RSS: Main: 194334720 02:39:59 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | Cycle 1(1): loaded http://localhost:37406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37406/tests/kraken/driver.html?testName=ai-astar) 02:40:01 INFO - PROCESS | 1598 | RSS: Main: 245473280 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | __start_tp_report 02:40:01 INFO - PROCESS | 1598 | _x_x_mozilla_page_load 02:40:01 INFO - PROCESS | 1598 | _x_x_mozilla_page_load_details 02:40:01 INFO - PROCESS | 1598 | |i|pagename|runs| 02:40:01 INFO - PROCESS | 1598 | |0;ai-astar;103;110;111;108;112;111;110;111;112;110 02:40:01 INFO - PROCESS | 1598 | |1;audio-beat-detection;155;117;125;191;119;121;146;118;159;117 02:40:01 INFO - PROCESS | 1598 | |2;audio-dft;160;161;161;160;162;161;160;163;161;161 02:40:01 INFO - PROCESS | 1598 | |3;audio-fft;74;76;74;123;75;76;75;74;102;76 02:40:01 INFO - PROCESS | 1598 | |4;audio-oscillator;83;83;128;84;83;84;118;83;84;120 02:40:01 INFO - PROCESS | 1598 | |5;imaging-gaussian-blur;117;116;118;117;117;117;117;116;117;117 02:40:01 INFO - PROCESS | 1598 | |6;imaging-darkroom;148;147;146;147;147;146;147;148;147;145 02:40:01 INFO - PROCESS | 1598 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;96 02:40:01 INFO - PROCESS | 1598 | |8;json-parse-financial;52;52;51;52;51;51;54;51;51;51 02:40:01 INFO - PROCESS | 1598 | |9;json-stringify-tinderbox;62;64;62;62;63;62;63;63;62;62 02:40:01 INFO - PROCESS | 1598 | |10;stanford-crypto-aes;78;85;75;76;75;76;75;76;75;76 02:40:01 INFO - PROCESS | 1598 | |11;stanford-crypto-ccm;126;121;120;120;126;126;119;135;164;120 02:40:01 INFO - PROCESS | 1598 | |12;stanford-crypto-pbkdf2;161;159;163;161;160;164;164;158;156;158 02:40:01 INFO - PROCESS | 1598 | |13;stanford-crypto-sha256-iterative;63;64;65;64;64;61;64;62;62;62 02:40:01 INFO - PROCESS | 1598 | __end_tp_report 02:40:01 INFO - PROCESS | 1598 | __start_cc_report 02:40:01 INFO - PROCESS | 1598 | _x_x_mozilla_cycle_collect,1656 02:40:01 INFO - PROCESS | 1598 | __end_cc_report 02:40:01 INFO - PROCESS | 1598 | __startTimestamp1469612401429__endTimestamp 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | ------- Summary: start ------- 02:40:01 INFO - PROCESS | 1598 | Number of tests: 14 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:1.24 02:40:01 INFO - PROCESS | 1598 | Values: 103.0 110.0 111.0 108.0 112.0 111.0 110.0 111.0 112.0 110.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:135.50 stddev:25.14 (18.6%) stddev-sans-first:25.79 02:40:01 INFO - PROCESS | 1598 | Values: 155.0 117.0 125.0 191.0 119.0 121.0 146.0 118.0 159.0 117.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:40:01 INFO - PROCESS | 1598 | Values: 160.0 161.0 161.0 160.0 162.0 161.0 160.0 163.0 161.0 161.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:16.59 (22.1%) stddev-sans-first:17.31 02:40:01 INFO - PROCESS | 1598 | Values: 74.0 76.0 74.0 123.0 75.0 76.0 75.0 74.0 102.0 76.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.00 stddev:18.80 (22.7%) stddev-sans-first:19.44 02:40:01 INFO - PROCESS | 1598 | Values: 83.0 83.0 128.0 84.0 83.0 84.0 118.0 83.0 84.0 120.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:40:01 INFO - PROCESS | 1598 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 02:40:01 INFO - PROCESS | 1598 | Values: 148.0 147.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 145.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:40:01 INFO - PROCESS | 1598 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:0.97 (1.9%) stddev-sans-first:1.01 02:40:01 INFO - PROCESS | 1598 | Values: 52.0 52.0 51.0 52.0 51.0 51.0 54.0 51.0 51.0 51.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:40:01 INFO - PROCESS | 1598 | Values: 62.0 64.0 62.0 62.0 63.0 62.0 63.0 63.0 62.0 62.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:3.06 (4.0%) stddev-sans-first:3.21 02:40:01 INFO - PROCESS | 1598 | Values: 78.0 85.0 75.0 76.0 75.0 76.0 75.0 76.0 75.0 76.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:126.00 stddev:13.65 (10.8%) stddev-sans-first:14.47 02:40:01 INFO - PROCESS | 1598 | Values: 126.0 121.0 120.0 120.0 126.0 126.0 119.0 135.0 164.0 120.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.00 stddev:2.72 (1.7%) stddev-sans-first:2.87 02:40:01 INFO - PROCESS | 1598 | Values: 161.0 159.0 163.0 161.0 160.0 164.0 164.0 158.0 156.0 158.0 02:40:01 INFO - PROCESS | 1598 | 02:40:01 INFO - PROCESS | 1598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 02:40:01 INFO - PROCESS | 1598 | Values: 63.0 64.0 65.0 64.0 64.0 61.0 64.0 62.0 62.0 62.0 02:40:01 INFO - PROCESS | 1598 | -------- Summary: end -------- 02:40:01 INFO - PROCESS | 1598 | 02:40:02 INFO - TEST-INFO | 1598: exit 0 02:40:02 INFO - TEST-OK | kraken | took 64237ms 02:40:02 INFO - SUITE-END | took 1183s 02:40:02 INFO - Completed test suite (00:19:43) 02:40:02 INFO - javascript benchmark 02:40:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.6509001464833, 3050.9694903050963, 3073.769467289954, 3094.644115926669, 3105.09952113887, 5031.220160875061, 5225.843224703265, 5349.224362467445, 5397.7301134943245, 5446.373667028298, 5319.148936170213, 5323.840284791462, 5375.059364611187, 5406.324209473816, 5420.728963551826, 4774.856754297368, 4776.665633405663, 4939.654224204289, 4978.128827455199, 4990.201567749143, 4968.925466118011, 4978.153713868651, 4986.077575648516, 4986.9750651246695, 4988.4762099979525, 4790.113828941657, 4823.710577365369, 4828.46886842447, 4945.184044632631, 4991.475895031006, 4829.879253018667, 4855.36880205571, 4865.732384718839, 4865.9756701216265, 4878.560929516325, 4833.444153922309, 4909.3126962225315, 4915.361003069578, 4921.335619691332, 4932.482089380635, 5187.429382767892, 5296.602754793367, 5423.05096608092, 5453.209284653703, 5472.26124473195, 5687.914681279784, 5769.9711501442225, 5770.567207459415, 5771.711414429304, 5772.797952071699, 5741.712914354307, 5799.420057994209, 5811.622244554091, 5811.88376232473, 5812.854678633068, 5180.352455943007, 5337.626366154332, 5372.382176049726, 5420.403755586883, 5425.37608175061, 5917.881642367129, 5972.761089556369, 5975.760969561169, 5976.760929562855, 5983.521318294526, 5682.914756278659, 5722.4277572242445, 5732.914006289909, 5733.684647344353, 5734.426557344233, 5549.5837812164245, 5670.716464176775, 5766.394528574523, 5804.2744656917885, 5810.4189581041555, 5708.885822283531, 5731.312242530923, 5754.683492407874, 5785.82642520725, 5790.478856902899, 5711.343195532484, 5750.654960702372, 5762.1068734346245, 5762.9135562966585, 5768.826935191951, 4282.293421585466, 4347.34789781529, 4396.648268138541, 4401.273789824707, 4406.074724307931, 3918.529776426847, 3935.4490371348033, 3965.0682089708894, 3989.202159568098, 4003.899902502461, 5491.258680078218, 5494.5054945054335, 5503.532199763065, 5505.091659876156, 5514.696691681916, 5566.443355664401, 5748.511376532958, 5836.241288632451, 5841.211436456109, 5868.530517558585, 5451.073317536028, 5514.696691681916, 5514.834554963358, 5546.168074788733, 5554.861128471821, 5018.623603229699, 5026.572741316956, 5028.195488721787, 5032.993401319751, 5069.087564238399, 5658.603897727119, 5857.414258574194, 6006.699665016732, 6018.488428483628, 6020.518358531394, 5742.770289188553, 5786.247787787561, 5787.39232380594, 5820.097884827858, 5839.386864379179, 5939.554533409925, 5939.990201665641, 5949.077892926603, 5952.0, 5957.136215248851, 5404.83785486436, 5579.553635709215, 5623.943760562342, 5673.602847800615, 5677.977963966526, 5586.581006424453, 5727.799527016535, 5733.770649173986, 5770.769169233184, 5821.09772985188, 5608.495235428831, 5612.326520817528, 5616.971915140398, 5617.297837770278, 5620.016497113071, 5424.593155513273, 5475.425080366664, 5609.607327487037, 5613.663180209037, 5615.971920140373, 5445.074337362578, 5489.64317319373, 5494.670319780826, 5533.806316778893, 5544.0, 5571.916421253765, 5578.163275508706, 5632.127020311858, 5632.605717599892, 5633.746481408264, 5345.679259244458, 5350.3312085989255, 5463.48096930791, 5465.070937940639, 5470.042742520122], "value": 5299.240956379507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6656006076536, 614.7971169514061, 623.9064140378943, 624.9812505624833, 633.9461145802603, 31585.68414315856, 33763.155921101985, 34042.48936265955, 34051.65948340516, 34064.0, 33760.49359259607, 43776.781116094455, 44296.0, 44322.11355772883, 47929.52070479294, 8949.507777072275, 9041.457512549236, 9083.682071127512, 9096.54517274137, 9097.818043639123, 8242.83514329713, 8963.327750418712, 9039.728808135766, 9046.773830654254, 10580.206484513692, 10555.472226388689, 10901.727456813564, 10924.781504369948, 10926.344419334826, 10944.616938407158, 10756.515956781963, 10814.134869210444, 10817.945910270437, 10824.458777061116, 10824.837627435594, 8037.196280371974, 8207.917920820775, 10511.054005139498, 10573.471326433648, 10668.093212076983, 38898.80550597229, 42932.14135717299, 42963.35554966678, 43011.35482967758, 43028.784856075836, 3522.4364101743854, 3783.2055268393397, 4116.636365452629, 4148.23257697324, 4328.156009578133, 32859.3428131436, 33550.83224583886, 33600.15999600005, 33697.15757106068, 33818.6618133818, 4389.670774691879, 4427.756473393962, 4522.3668686383935, 4533.546645335473, 4618.676692631517, 248794.0, 249037.0, 249504.0, 249975.0, 251284.99999999817, 57160.0, 57510.0, 57530.42469575335, 57669.711651441474, 57708.13437798437, 53137.0, 53605.463945360825, 53615.73192134014, 53747.46252537503, 53791.731041344545, 15918.840811591968, 15971.520854374387, 16100.677986440205, 16101.0, 16178.75731864023, 13061.673458163621, 13071.281079540717, 13143.211407315592, 13160.47358105665, 13172.143810652276, 14222.644433889236, 15300.469953004833, 15718.449854255046, 15731.954845869963, 15838.52484425469, 5051.4695956924725, 5782.59521833476, 5812.680302583399, 5852.502537284294, 5906.734196961147, 898.9101089890959, 965.666844938495, 1120.025577747365, 1133.812920868064, 1169.859616845984, 32122.678773212436, 32430.0, 32495.350092998007, 32864.50703239453, 33122.8343858284, 1078.218291738499, 1104.4146602300793, 1130.2992144870234, 1139.7378602921374, 1154.4054811771944, 16937.91531042337, 16980.320787168373, 17084.572885677957, 17222.655546889244, 17286.481405557854, 553011.0, 555333.0, 559557.0, 559831.0, 561179.0, 57234.7138264306, 57261.0, 57321.0, 57409.71295143497, 57538.0, 1317.3939987605809, 1349.817774600436, 1376.057400680537, 1381.2748307138631, 1383.0180571793937, 30456.629451674286, 31990.0, 32009.879654211993, 32783.180420489676, 33267.33465330728, 52138.73930630323, 52449.47550524446, 52455.73772131115, 52574.73712631565, 52598.0, 490878.0, 495785.2528848281, 496031.0, 499726.0, 500384.0, 41634.79182604189, 41844.58155418407, 42828.0, 42961.0, 42962.0, 48107.518924810305, 48912.26631600458, 49034.75482622564, 49124.26313605227, 49388.75305623449, 40347.59652403439, 41368.79315603403, 41479.0, 42044.36933446062, 42851.785741072345, 40924.72602191758, 41456.0, 41549.792251038554, 41902.79048604737, 42291.788541057096, 40992.1801563973, 41282.793586031876, 42130.0, 42153.156936860476, 42203.0, 33861.830690847375, 36599.0, 36870.262594747415, 37207.0, 37869.62130378661, 28189.81990277298, 28294.292642683275, 28367.716322836506, 28422.87348391634, 28485.145445636663], "value": 20269.33940638447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1269511081847, 385.9266739319531, 391.205852120196, 395.82979318892865, 410.9876703698888, 14028.859711402883, 15831.525054248377, 18459.0, 18903.621927561442, 19029.0, 18954.0, 19012.0, 19024.809751902478, 19217.711734323962, 19237.807621923777, 4327.32926396409, 5636.351819540764, 5812.680302583356, 5828.47543721065, 5847.619904706181, 4813.374261346037, 6554.672266386661, 6641.203055633331, 6723.159605049369, 6736.124303840494, 6371.0, 6464.256610489807, 6507.023946408053, 6682.131322928012, 6687.765928192514, 6311.873762524724, 6499.0, 6523.739050438001, 6563.868722625544, 6566.080748695211, 5632.7746890124345, 5687.857803554903, 5690.943090569082, 5691.686957217351, 5694.174344720034, 23118.42203944898, 23570.0, 23708.0, 23757.88121059401, 23842.76157238423, 2391.426057746146, 2450.399652085233, 2531.9240422787348, 2867.311845157168, 3026.803257788237, 13949.58151255464, 14832.258387080603, 14866.925665371713, 15086.0, 15170.317335719808, 1909.1122627977918, 1942.417274817549, 2030.5837303352926, 2071.357879057482, 2077.979220207794, 78577.60711196465, 79381.60309198475, 80043.0, 81354.18645813584, 82619.0, 10532.789344213226, 10931.508082136323, 10979.670609881716, 11223.66329010131, 11320.26418282809, 14808.407663693548, 15186.012909160869, 15262.31319590621, 15281.847181528043, 15408.922955385375, 7916.960415198002, 8080.515169089874, 8127.106018337978, 8145.837083258301, 8169.468984515987, 7583.696652133964, 7758.9612051939375, 7819.84360312802, 7860.646270917708, 8172.67309307633, 4535.160995215896, 4560.429946256718, 4587.632989360844, 4618.56123668251, 4854.975725121351, 1853.2031226572433, 1905.7617797775279, 1916.377177417345, 1919.7120431935043, 1943.89308588029, 957.5212393803098, 961.5240605670263, 977.7408986618552, 978.0415193110649, 994.1500017485091, 19549.315773947845, 19898.403047908585, 19982.70025949612, 20078.0, 20095.59808803845, 943.8961714211431, 976.3995142987012, 977.9975327113899, 988.0564061321421, 1008.0322890025511, 8157.3881958852135, 11132.777344453065, 11137.665870023913, 11149.219554631098, 11151.553937842395, 469886.0, 470548.0, 483860.0, 488502.0, 490686.0, 90116.0, 90187.54906225558, 91662.54168729113, 92625.5368723152, 93325.5333723327, 933.7805615680445, 942.3356533643764, 961.0485619237045, 964.0793042644258, 968.9806203875883, 15924.124173170587, 17357.47927562175, 17738.5565360867, 17806.554836129202, 18208.544786380447, 42310.36534452047, 42826.78586607047, 42851.571484286, 43429.13141737211, 44099.77950110229, 51761.48238517717, 53731.462685372644, 57077.71461142668, 58061.0, 58280.0, 7568.3945284378215, 7826.2173782621285, 8011.919880801117, 8068.636911338886, 8178.223068808454, 10786.352818830896, 12804.423800928795, 12877.16298440636, 13042.282674452996, 13298.135621184592, 6193.69932314219, 11112.555497780322, 11257.437128143723, 11624.535018599161, 11663.066954643438, 11259.493322800658, 11488.253263537843, 11512.942435288105, 11664.825027624762, 11670.649880503599, 11447.313161210353, 11554.76890462203, 11705.414729263332, 12060.819087713868, 12130.93934530357, 7984.441089123706, 7992.760217193493, 8249.133840946613, 8299.419040667095, 8417.242448179693, 10307.690769276935, 11462.197646165023, 11632.243904146204, 11678.88321116778, 11996.100292477924], "value": 9287.205534787594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.0418700629048, 1394.2122700674117, 1480.3412481445757, 1536.231884057971, 1717.0470388934136, 8592.65629374825, 8925.375223734341, 8959.596818143184, 9022.323325750562, 9025.323100767437, 8955.955220223907, 9010.053944335848, 9043.050479699636, 9045.231155351787, 9051.0, 2420.165043060141, 2444.4133407982135, 2448.461338505526, 2449.5713250181234, 2450.2894160693377, 2400.795932345744, 2422.9151979680714, 2454.8772561371948, 2458.7049554053538, 2461.3600463879343, 2377.2749311459997, 2395.5448464791634, 2419.7701218384227, 2426.1993542131054, 2430.2952143878256, 2273.5680220758086, 2284.4859906521065, 2288.599495088361, 2296.150424342987, 2344.3318654183645, 2245.3376254005107, 2275.306031660343, 2287.885605719707, 2288.1305104060516, 2296.6555016747457, 8744.956275218647, 8913.28693704502, 8948.865767013434, 8967.68613098545, 8996.505192214425, 5265.578753699695, 5499.670019798825, 5509.090999984997, 5511.173324001432, 5521.365043020024, 3416.7095796857298, 3453.723702103826, 3495.2135769451925, 3495.5106285120105, 3502.562179727534, 1111.0611533254387, 1165.091228841505, 1169.421136537411, 1186.35936594239, 1190.0836356005827, 12501.24992500453, 12594.0, 12611.180273282116, 12640.936795315965, 12671.0, 4337.7397356158735, 4494.52807455219, 4610.654200934943, 4612.630989520831, 4681.250999840009, 9868.358556693793, 9921.50392480373, 9927.751806204902, 9928.851067233998, 9938.155256803253, 5189.896202075937, 5215.7913683453, 5217.973910130501, 5220.138677118309, 5221.425643179247, 4291.527931927485, 4861.197902346144, 4889.731064791471, 5004.3994720633755, 5032.0, 3792.810359482015, 3841.1741475582885, 3922.0783115967724, 3924.411338299221, 3997.6002399760373, 1069.4706120470416, 1161.6282789507277, 1176.5470293936726, 1177.3465726521863, 1187.3172925567833, 858.3047731337637, 904.2178515584104, 989.7327721515151, 998.8701468809008, 1016.539805402401, 6031.638101713911, 6073.331933487313, 6255.655938923312, 6274.247090349188, 6295.527835412362, 978.7797745507346, 994.2692121290845, 1003.9949800251098, 1004.7237009822358, 1022.8465730140539, 4363.946810675583, 4431.911361772811, 4472.664550158751, 4530.77346132692, 4631.58315751584, 11075.0, 11107.111431085494, 11189.944050279697, 11211.990920817165, 11215.271007384494, 11154.21920465576, 11155.49800258974, 11155.776884462428, 11164.330140191452, 11175.664730057948, 8227.506349619041, 8515.74452766418, 8523.744287671256, 8603.440776349516, 8608.440451370767, 6228.688565571794, 6235.688215589294, 6341.175647165839, 6353.968230159005, 6457.056133554462, 9965.800683986425, 10268.897311027093, 10281.0, 10332.483375831029, 10341.689749307232, 10339.793204136025, 10342.5345859435, 10360.067593916583, 10364.015418535228, 10373.688789336333, 8175.509469431853, 8184.54984975832, 8187.836243274982, 8267.379946504156, 8371.079181289932, 8889.866652000095, 8994.910050899407, 9017.549122543978, 9018.188363047357, 9024.774380640536, 7547.358474529727, 7789.5715735635085, 7793.649285782267, 7822.530648161129, 7942.64258108375, 7931.405144614062, 7952.244536768998, 8002.879956800536, 8073.959630201812, 8195.836083278182, 6948.965255173692, 6961.095057642474, 6969.4424446045205, 7022.894656580053, 7028.051213086168, 5236.136037553761, 5266.73666316675, 5288.0, 5299.046171689133, 5352.35771707382, 5205.973970130125, 5221.373435187802, 5266.1574148136115, 5288.65623734456, 5297.046531624344], "value": 4727.074427643833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.08401685323224, 335.92945481448896, 338.8678415417987, 342.746367687911, 344.22205814858427, 5340.652857564261, 5352.411234764173, 5357.678539287641, 5364.812231571896, 5395.271638328824, 5045.77294021769, 5129.9230511542355, 5213.244079608455, 5219.877726288857, 5303.575713942885, 4157.168566286739, 4163.770992595406, 4165.854195103172, 4170.728902621335, 4170.833166673345, 4167.229062623409, 4170.04089059515, 4177.12280421112, 4191.517975432818, 4193.35003074524, 3880.553736320331, 3906.335922893101, 4129.958700413003, 4140.0, 4166.166766646667, 4085.20338533986, 4105.91788164238, 4127.711060225785, 4130.607592278729, 4132.2355364257555, 3637.236180402119, 3645.453182022691, 3653.451982202664, 3656.341858465475, 3671.94492082619, 5075.162598171298, 5141.562967147759, 5157.252198431244, 5190.143626301693, 5191.428942816287, 4709.599684026827, 4717.386739723848, 4742.359781429497, 4743.288506723985, 4748.857534273943, 5464.836054918359, 5464.863378415532, 5477.685355514648, 5496.642718223303, 5523.7238138092935, 3923.509561304837, 4061.431399604058, 4074.409210664437, 4078.836846526165, 4084.979575102135, 5731.0, 5733.913991290134, 5738.282714660668, 5749.425057494217, 5749.942500574983, 4199.265128602544, 4204.3693445982735, 4208.284591619432, 4211.073563815956, 4217.5782421758195, 3988.521377434726, 4239.936400953989, 4246.363045543131, 4256.978715106405, 4262.50981137167, 4780.705261474512, 4782.497837726988, 4786.659735274129, 4793.688410253322, 4799.3041009053495, 5577.972110139504, 5591.099026331067, 5597.384287728347, 5604.215409842625, 5606.943930560724, 1386.932062312014, 1452.8692417682248, 1468.119128522899, 1474.71243107593, 1480.9407623695147, 950.5342382232657, 1010.1010101010107, 1030.3354336453096, 1034.1003327105466, 1039.3763741755038, 5315.548178404802, 5321.308229930084, 5335.706536140472, 5349.732513374316, 5370.543503802142, 5586.692731899703, 5601.831945041656, 5613.522850557667, 5629.155626655953, 5647.519960803378, 5206.140986737221, 5297.602679799031, 5306.7611957462, 5310.867228319245, 5328.37484567203, 2975.5982942302944, 2983.2243616659825, 2989.970100298969, 2997.7901546891944, 3004.4742170120144, 5559.776849093193, 5757.625754326039, 5772.884542309131, 5780.0, 5797.231844287533, 5596.272484576979, 5617.719114044281, 5707.571932105108, 5733.741981610838, 5749.396313387034, 5742.741576628978, 5768.221290125864, 5777.74000169985, 5783.537317014713, 5786.363500014911, 5459.181122831607, 5552.805651802168, 5665.376808550974, 5758.827235182951, 5763.308402991668, 5599.524040456444, 5611.298587676541, 5618.185363122406, 5683.8863222736145, 5684.971575142098, 5695.202671626059, 5840.561957853263, 5889.823305300848, 5889.998700220887, 5915.822525324247, 3987.72085953992, 4020.015096301425, 4025.0, 4041.2927737645205, 4044.8786536403954, 5752.07966725322, 5756.194132821324, 5768.394318596487, 5774.422557744192, 5784.392638773036, 5474.698891561003, 5591.944080559142, 5597.692126933058, 5617.719114044363, 5641.802536911188, 5561.582881284001, 5567.137093750475, 5603.243562119224, 5608.579356548194, 5610.438956104357, 5267.157254839208, 5331.626786124934, 5506.962423903182, 5521.889562208653, 5534.529564987021, 5588.217649528988, 5593.412691667317, 5594.727084655359, 5600.803971860965, 5615.157726341082, 5491.32514583056, 5493.917591236055, 5502.477264659851, 5513.558915286687, 5515.393306736336], "value": 4254.264061088253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.9032916050074, 828.2462958707576, 834.9874751878723, 859.4714250735791, 874.1651722604909, 14978.0, 15051.698966020673, 15103.77344339833, 16379.262933168005, 16424.014559126445, 16647.50057498277, 16865.915670421662, 16887.408940687077, 16912.83087169128, 16933.57666058349, 813.0812182234082, 825.5129473610568, 826.3017750001269, 826.6114925984778, 827.2224109337234, 661.2692974263442, 788.5190034079208, 798.5408390175672, 799.6441583495347, 822.0956947357919, 856.7943693513542, 860.9225169734723, 861.130258438978, 861.7587075618836, 863.3136656358179, 853.1425916953453, 855.3200205836375, 855.7304449098546, 856.2764464027887, 856.5717141429285, 503.48141414343286, 598.494272339872, 604.8215776345944, 610.3865615056884, 616.9876602467971, 15281.923590381977, 15311.693766124616, 15320.616984575474, 15864.841351586567, 15907.0, 14302.427902883976, 14320.856791432056, 14550.927245363811, 14895.47865824691, 14921.776173357408, 13305.334733263298, 13449.462021519128, 13513.932430337883, 13535.458581656721, 14194.0, 4565.201089809303, 4640.79116439761, 4765.070811191819, 4840.080384726926, 4845.3216549683075, 75434.0, 76009.61995190044, 76970.0, 77111.0, 77395.61302193454, 12182.573609923611, 12322.199057061442, 12368.81446778299, 12403.503859845685, 12865.228086314852, 22491.0, 22491.66262506064, 22558.548829023326, 22657.4335641607, 22675.0, 8352.8329433411, 8389.916100839035, 8506.617202225914, 8555.614997325136, 8872.06843281459, 4794.640401969867, 4812.494688057774, 4823.2282834746275, 4916.72957987307, 5064.4935506449065, 3566.625504322061, 3644.3075815594952, 3681.2637472505608, 3691.630836916287, 3696.537932758405, 632.4813652804656, 648.3160265919406, 651.7393042782925, 652.1196384880374, 683.6547543490605, 555.9833205003856, 618.227215980025, 687.4156966578369, 694.5138403117737, 696.345435290825, 9032.36773425854, 9075.27397808187, 9353.345265831327, 9671.564779584794, 9924.851127233098, 560.6075746977132, 561.4469747298907, 638.9903951756214, 647.9244454205996, 703.7994171661052, 4393.934090988638, 4475.48531918827, 4699.906001879944, 4774.880627984328, 4781.928271075936, 110148.0, 113445.43277283726, 113632.43183784194, 116416.41791790987, 118050.0, 96975.0, 98877.50561247148, 101256.89944804399, 101593.0, 102456.48771756093, 84845.57577212075, 85584.0, 88367.55816220878, 89455.0, 90058.0, 8759.562021899006, 8771.561421929006, 8941.37410381267, 8956.68651597191, 8977.371583989057, 50892.20092894778, 51118.48881511137, 52541.0, 53512.0, 54195.45804541904, 66399.0, 66672.66663666845, 69058.65470672614, 76021.61989190019, 76357.61821190859, 13261.602151935458, 13644.863551364757, 13687.0, 14162.645933851736, 14172.291385430894, 14631.561053168421, 14838.777418338517, 14909.552713418614, 15050.698986020438, 15497.30262138184, 13475.0, 14131.505397311044, 14348.139111653334, 14412.927935360256, 14602.926985365006, 13308.93345533266, 13877.167369957835, 13894.722105558034, 13941.745242928186, 14421.7836732447, 13752.65618359549, 14509.782353264498, 14645.41418343297, 15123.16822574769, 15156.166410847509, 11536.134789890959, 11580.768384632429, 11813.350265735467, 11930.821037684269, 11935.462904169506, 11676.591319303783, 12077.51689932393, 12089.335086570323, 12186.756264874475, 12248.0], "value": 7731.262953842027, "unit": "score"}], "name": "dromaeo_css", "value": 7330.074749235025, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 108.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 125.0, 191.0, 119.0, 121.0, 146.0, 118.0, 159.0, 117.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0, 163.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 123.0, 75.0, 76.0, 75.0, 74.0, 102.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 128.0, 84.0, 83.0, 84.0, 118.0, 83.0, 84.0, 120.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 51.0, 51.0, 54.0, 51.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 85.0, 75.0, 76.0, 75.0, 76.0, 75.0, 76.0, 75.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 120.0, 120.0, 126.0, 126.0, 119.0, 135.0, 164.0, 120.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 161.0, 160.0, 164.0, 164.0, 158.0, 156.0, 158.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 61.0, 64.0, 62.0, 62.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1486.0, "alertThreshold": 2.0}]} 02:40:02 INFO - Return code: 0 02:40:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:02 INFO - # TBPL SUCCESS # 02:40:02 INFO - Running post-action listener: _resource_record_post_action 02:40:02 INFO - [mozharness: 2016-07-27 09:40:02.745244Z] Finished run-tests step (success) 02:40:02 INFO - Running post-run listener: _resource_record_post_run 02:40:02 INFO - Total resource usage - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 573755392; Read time: 1496; Write time: 4238316 02:40:02 INFO - TinderboxPrint: CPU usage
13.5% 02:40:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 1,496 02:40:02 INFO - TinderboxPrint: I/O write bytes / time
573,755,392 / 4,238,316 02:40:02 INFO - TinderboxPrint: CPU idle
8,375.4 (86.5%) 02:40:02 INFO - TinderboxPrint: CPU user
1,192.5 (12.3%) 02:40:02 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:02 INFO - install - Wall time: 28s; CPU: 23.0%; Read bytes: 0; Write bytes: 256290816; Read time: 0; Write time: 2670292 02:40:02 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308572160; Read time: 1496; Write time: 1534696 02:40:03 INFO - Running post-run listener: _upload_blobber_files 02:40:03 INFO - Blob upload gear active. 02:40:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:03 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 02:40:03 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'] 02:40:03 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 02:40:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:04 INFO - (blobuploader) - INFO - Done attempting. 02:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:12 INFO - (blobuploader) - INFO - Done attempting. 02:40:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:13 INFO - (blobuploader) - INFO - Done attempting. 02:40:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:13 INFO - Return code: 0 02:40:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cf0f4b0d2889d490a8fe551f371843d18105c177aab19c37db986cbe8005020c38151ea401e7ee99e7989c0e773114621f535fba647c37cac97bf6137586d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8a8372194592881f4d0ff410c4ac834b61c0686ee63e4adc85b9c5f97fe4bef1b5030b6f1451143a837d29bfc9fc603d6071e8ec05738244fd437ae49dd44d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03aeeacd12736f62c2f001d3ff0007f67ce054c9dfc9a9ab0a7f29e4283a12d3e24ee01d9f763b62bd9588b780a176e022627e427737317fcba947fbac7074d3"} 02:40:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:13 INFO - Contents: 02:40:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cf0f4b0d2889d490a8fe551f371843d18105c177aab19c37db986cbe8005020c38151ea401e7ee99e7989c0e773114621f535fba647c37cac97bf6137586d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8a8372194592881f4d0ff410c4ac834b61c0686ee63e4adc85b9c5f97fe4bef1b5030b6f1451143a837d29bfc9fc603d6071e8ec05738244fd437ae49dd44d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03aeeacd12736f62c2f001d3ff0007f67ce054c9dfc9a9ab0a7f29e4283a12d3e24ee01d9f763b62bd9588b780a176e022627e427737317fcba947fbac7074d3"} 02:40:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:13 INFO - Copying logs to upload dir... 02:40:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.862684 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-27 02:40:13.576335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 02:40:13.580377) ========= 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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 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/47cf0f4b0d2889d490a8fe551f371843d18105c177aab19c37db986cbe8005020c38151ea401e7ee99e7989c0e773114621f535fba647c37cac97bf6137586d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8a8372194592881f4d0ff410c4ac834b61c0686ee63e4adc85b9c5f97fe4bef1b5030b6f1451143a837d29bfc9fc603d6071e8ec05738244fd437ae49dd44d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03aeeacd12736f62c2f001d3ff0007f67ce054c9dfc9a9ab0a7f29e4283a12d3e24ee01d9f763b62bd9588b780a176e022627e427737317fcba947fbac7074d3"} build_url:https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/XN89OaETRNibIoR1K7PshQ/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/47cf0f4b0d2889d490a8fe551f371843d18105c177aab19c37db986cbe8005020c38151ea401e7ee99e7989c0e773114621f535fba647c37cac97bf6137586d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8a8372194592881f4d0ff410c4ac834b61c0686ee63e4adc85b9c5f97fe4bef1b5030b6f1451143a837d29bfc9fc603d6071e8ec05738244fd437ae49dd44d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03aeeacd12736f62c2f001d3ff0007f67ce054c9dfc9a9ab0a7f29e4283a12d3e24ee01d9f763b62bd9588b780a176e022627e427737317fcba947fbac7074d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 02:40:13.605609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:40:13.605935) ========= 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=33d5923976266a1c518c4bf7000001ab-1469610304.71419-1938824152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:40:13.689845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 02:40:13.690248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 02:40:13.690604) ========= ========= Total master_lag: 0.15 =========