builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1469614189.27 results: success (0) buildid: 20160727023615 builduid: de66e6b444534b51a8afd112f0e82569 revision: 96de0b18cace15865b2d013110e9c70aa7d9d6d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.269857) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.270313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.270581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.322768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.323101) ========= 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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 03:09:49-- 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% 223M=0s 2016-07-27 03:09:49 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166217 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.529978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.530268) ========= 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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.072784 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:49.618541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 03:09:49.618839) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96de0b18cace15865b2d013110e9c70aa7d9d6d8 --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 96de0b18cace15865b2d013110e9c70aa7d9d6d8 --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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 03:09:49,621 truncating revision to first 12 chars 2016-07-27 03:09:49,621 Setting DEBUG logging. 2016-07-27 03:09:49,621 attempt 1/10 2016-07-27 03:09:49,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96de0b18cace?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 03:09:50,836 unpacking tar archive at: fx-team-96de0b18cace/testing/mozharness/ program finished with exit code 0 elapsedTime=1.551074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 03:09:51.184050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:51.184604) ========= script_repo_revision: 96de0b18cace15865b2d013110e9c70aa7d9d6d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:51.185200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:51.185535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:09:51.196629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-27 03:09:51.197021) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:51 INFO - MultiFileLogger online at 20160727 03:09:51 in /builds/slave/test 03:09:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:09:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:51 INFO - {'append_to_log': False, 03:09:51 INFO - 'base_work_dir': '/builds/slave/test', 03:09:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:09:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:51 INFO - 'branch': 'Fx-Team-Non-PGO', 03:09:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:51 INFO - 'config_files': ('talos/linux_config.py',), 03:09:51 INFO - 'default_actions': ('clobber', 03:09:51 INFO - 'read-buildbot-config', 03:09:51 INFO - 'download-and-extract', 03:09:51 INFO - 'populate-webroot', 03:09:51 INFO - 'create-virtualenv', 03:09:51 INFO - 'install', 03:09:51 INFO - 'run-tests'), 03:09:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:51 INFO - 'download_minidump_stackwalk': True, 03:09:51 INFO - 'download_symbols': 'ondemand', 03:09:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:51 INFO - 'installer_path': 'installer.exe', 03:09:51 INFO - 'log_level': 'info', 03:09:51 INFO - 'log_name': 'talos', 03:09:51 INFO - 'log_to_console': True, 03:09:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:51 INFO - 'opt_config_files': (), 03:09:51 INFO - 'pip_index': False, 03:09:51 INFO - 'sps_profile': False, 03:09:51 INFO - 'sps_profile_interval': 0, 03:09:51 INFO - 'suite': 'dromaeojs', 03:09:51 INFO - 'system_bits': '32', 03:09:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:51 INFO - 'title': 'talos-linux64-ix-038', 03:09:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:51 INFO - 'use_talos_json': True, 03:09:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:51 INFO - 'work_dir': 'build'} 03:09:51 INFO - [mozharness: 2016-07-27 10:09:51.398459Z] Running clobber step. 03:09:51 INFO - Running pre-action listener: _resource_record_pre_action 03:09:51 INFO - Running main action method: clobber 03:09:51 INFO - rmtree: /builds/slave/test/build 03:09:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:52 INFO - Running post-action listener: _resource_record_post_action 03:09:52 INFO - [mozharness: 2016-07-27 10:09:52.530982Z] Finished clobber step (success) 03:09:52 INFO - [mozharness: 2016-07-27 10:09:52.531108Z] Running read-buildbot-config step. 03:09:52 INFO - Running pre-action listener: _resource_record_pre_action 03:09:52 INFO - Running main action method: read_buildbot_config 03:09:52 INFO - Using buildbot properties: 03:09:52 INFO - { 03:09:52 INFO - "project": "", 03:09:52 INFO - "product": "firefox", 03:09:52 INFO - "script_repo_revision": "production", 03:09:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:09:52 INFO - "repository": "", 03:09:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:09:52 INFO - "buildid": "20160727023615", 03:09:52 INFO - "pgo_build": "False", 03:09:52 INFO - "basedir": "/builds/slave/test", 03:09:52 INFO - "buildnumber": 1830, 03:09:52 INFO - "slavename": "talos-linux64-ix-038", 03:09:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:09:52 INFO - "platform": "ubuntu64_hw", 03:09:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:09:52 INFO - "branch": "fx-team", 03:09:52 INFO - "repo_path": "integration/fx-team", 03:09:52 INFO - "revision": "96de0b18cace15865b2d013110e9c70aa7d9d6d8", 03:09:52 INFO - "stage_platform": "linux64", 03:09:52 INFO - "builduid": "de66e6b444534b51a8afd112f0e82569", 03:09:52 INFO - "slavebuilddir": "test" 03:09:52 INFO - } 03:09:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:09:52 INFO - Running post-action listener: _resource_record_post_action 03:09:52 INFO - [mozharness: 2016-07-27 10:09:52.534233Z] Finished read-buildbot-config step (success) 03:09:52 INFO - [mozharness: 2016-07-27 10:09:52.534347Z] Running download-and-extract step. 03:09:52 INFO - Running pre-action listener: _resource_record_pre_action 03:09:52 INFO - Running main action method: download_and_extract 03:09:52 INFO - mkdir: /builds/slave/test/build/tests 03:09:52 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')]} 03:09:52 INFO - https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:09:59 INFO - Downloaded 1361 bytes. 03:09:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:09:59 INFO - Using the following test package requirements: 03:09:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:09:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'jsshell-linux-x86_64.zip'], 03:09:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:09:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:09:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:59 INFO - https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:04 INFO - Downloaded 22744359 bytes. 03:10:04 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'] 03:10:04 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 03:10:06 INFO - Return code: 0 03:10:06 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 03:10:06 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')]} 03:10:06 INFO - https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:08 INFO - Downloaded 22744359 bytes. 03:10:08 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'] 03:10:08 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 03:10:09 INFO - Return code: 0 03:10:09 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')]} 03:10:09 INFO - https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:11 INFO - Downloaded 14413725 bytes. 03:10:11 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'] 03:10:11 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 03:10:11 INFO - Return code: 0 03:10:11 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')]} 03:10:11 INFO - https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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 03:10:12 INFO - Downloaded 57168275 bytes. 03:10:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:10:12 INFO - mkdir: /builds/slave/test/properties 03:10:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:12 INFO - Contents: 03:10:12 INFO - build_url:https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:10:13 INFO - Running post-action listener: _resource_record_post_action 03:10:13 INFO - Running post-action listener: set_extra_try_arguments 03:10:13 INFO - [mozharness: 2016-07-27 10:10:13.366863Z] Finished download-and-extract step (success) 03:10:13 INFO - [mozharness: 2016-07-27 10:10:13.367095Z] Running populate-webroot step. 03:10:13 INFO - Running pre-action listener: _resource_record_pre_action 03:10:13 INFO - Running main action method: populate_webroot 03:10:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:13 INFO - '--tppagecycles', 03:10:13 INFO - '7'], 03:10:13 INFO - 'tests': ['tsvgm']}}, 03:10:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['damp', 'tps']}, 03:10:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'tests': ['damp', 'tps']}, 03:10:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['dromaeo_dom']}, 03:10:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['basic_compositor_video']}, 03:10:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:10:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['a11yr', 03:10:13 INFO - 'ts_paint', 03:10:13 INFO - 'tpaint', 03:10:13 INFO - 'sessionrestore', 03:10:13 INFO - 'sessionrestore_no_auto_restore', 03:10:13 INFO - 'tabpaint']}, 03:10:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['tsvgx', 03:10:13 INFO - 'tsvgr_opacity', 03:10:13 INFO - 'tart', 03:10:13 INFO - 'tscrollx', 03:10:13 INFO - 'cart']}, 03:10:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:13 INFO - 'tsvgr_opacity', 03:10:13 INFO - 'tart', 03:10:13 INFO - 'tscrollx', 03:10:13 INFO - 'cart']}, 03:10:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'talos_options': ['--disable-e10s'], 03:10:13 INFO - 'tests': ['tp5o']}, 03:10:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'tests': ['tp5o']}, 03:10:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'talos_options': ['--disable-e10s', 03:10:13 INFO - '--xperf_path', 03:10:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:13 INFO - 'tests': ['tp5n']}, 03:10:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:13 INFO - 'talos_options': ['--xperf_path', 03:10:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:13 INFO - 'tests': ['tp5n']}}, 03:10:13 INFO - 'talos.zip': {'path': '', 03:10:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:13 INFO - Running post-action listener: _resource_record_post_action 03:10:13 INFO - [mozharness: 2016-07-27 10:10:13.389458Z] Finished populate-webroot step (success) 03:10:13 INFO - [mozharness: 2016-07-27 10:10:13.389547Z] Running create-virtualenv step. 03:10:13 INFO - Running pre-action listener: _resource_record_pre_action 03:10:13 INFO - Running main action method: create_virtualenv 03:10:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:13 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 03:10:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:13 INFO - Using real prefix '/usr' 03:10:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:18 INFO - Installing pip.................done. 03:10:18 INFO - Return code: 0 03:10:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:18 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:18 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 03:10:18 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 03:10:18 INFO - Using env: {'DISPLAY': ':0', 03:10:18 INFO - 'HOME': '/home/cltbld', 03:10:18 INFO - 'LANG': 'en_US.UTF-8', 03:10:18 INFO - 'LANGUAGE': 'en_US:en', 03:10:18 INFO - 'LOGNAME': 'cltbld', 03:10:18 INFO - 'MAIL': '/var/mail/cltbld', 03:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:18 INFO - 'MOZ_NO_REMOTE': '1', 03:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:18 INFO - 'NO_EM_RESTART': '1', 03:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:18 INFO - 'PWD': '/builds/slave/test', 03:10:18 INFO - 'SHELL': '/bin/bash', 03:10:18 INFO - 'SHLVL': '1', 03:10:18 INFO - 'TERM': 'linux', 03:10:18 INFO - 'TMOUT': '86400', 03:10:18 INFO - 'USER': 'cltbld', 03:10:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:18 INFO - '_': '/tools/buildbot/bin/python'} 03:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:22 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 03:10:22 INFO - Cleaning up... 03:10:22 INFO - Return code: 0 03:10:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:10:22 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')]} 03:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:22 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')]} 03:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:22 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:22 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 03:10:22 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 03:10:22 INFO - Using env: {'DISPLAY': ':0', 03:10:22 INFO - 'HOME': '/home/cltbld', 03:10:22 INFO - 'LANG': 'en_US.UTF-8', 03:10:22 INFO - 'LANGUAGE': 'en_US:en', 03:10:22 INFO - 'LOGNAME': 'cltbld', 03:10:22 INFO - 'MAIL': '/var/mail/cltbld', 03:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:22 INFO - 'MOZ_NO_REMOTE': '1', 03:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:22 INFO - 'NO_EM_RESTART': '1', 03:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:22 INFO - 'PWD': '/builds/slave/test', 03:10:22 INFO - 'SHELL': '/bin/bash', 03:10:22 INFO - 'SHLVL': '1', 03:10:22 INFO - 'TERM': 'linux', 03:10:22 INFO - 'TMOUT': '86400', 03:10:22 INFO - 'USER': 'cltbld', 03:10:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:22 INFO - '_': '/tools/buildbot/bin/python'} 03:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:22 INFO - Downloading/unpacking psutil>=3.1.1 03:10:22 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 03:10:22 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 03:10:22 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 03:10:22 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 03:10:22 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 03:10:22 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 03:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:24 INFO - Installing collected packages: psutil 03:10:24 INFO - Running setup.py install for psutil 03:10:24 INFO - building 'psutil._psutil_linux' extension 03:10:24 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 03:10:26 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 03:10:26 INFO - building 'psutil._psutil_posix' extension 03:10:26 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 03:10:26 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 03:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:26 INFO - Successfully installed psutil 03:10:26 INFO - Cleaning up... 03:10:26 INFO - Return code: 0 03:10:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:10:26 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')]} 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:26 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')]} 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:26 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:26 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 03:10:26 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 03:10:26 INFO - Using env: {'DISPLAY': ':0', 03:10:26 INFO - 'HOME': '/home/cltbld', 03:10:26 INFO - 'LANG': 'en_US.UTF-8', 03:10:26 INFO - 'LANGUAGE': 'en_US:en', 03:10:26 INFO - 'LOGNAME': 'cltbld', 03:10:26 INFO - 'MAIL': '/var/mail/cltbld', 03:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:26 INFO - 'MOZ_NO_REMOTE': '1', 03:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:26 INFO - 'NO_EM_RESTART': '1', 03:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:26 INFO - 'PWD': '/builds/slave/test', 03:10:26 INFO - 'SHELL': '/bin/bash', 03:10:26 INFO - 'SHLVL': '1', 03:10:26 INFO - 'TERM': 'linux', 03:10:26 INFO - 'TMOUT': '86400', 03:10:26 INFO - 'USER': 'cltbld', 03:10:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:26 INFO - '_': '/tools/buildbot/bin/python'} 03:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:10:28 INFO - Installing collected packages: mozsystemmonitor 03:10:28 INFO - Running setup.py install for mozsystemmonitor 03:10:28 INFO - Successfully installed mozsystemmonitor 03:10:28 INFO - Cleaning up... 03:10:28 INFO - Return code: 0 03:10:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:10:28 INFO - Using env: {'DISPLAY': ':0', 03:10:28 INFO - 'HOME': '/home/cltbld', 03:10:28 INFO - 'LANG': 'en_US.UTF-8', 03:10:28 INFO - 'LANGUAGE': 'en_US:en', 03:10:28 INFO - 'LOGNAME': 'cltbld', 03:10:28 INFO - 'MAIL': '/var/mail/cltbld', 03:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:28 INFO - 'MOZ_NO_REMOTE': '1', 03:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:28 INFO - 'NO_EM_RESTART': '1', 03:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:28 INFO - 'PWD': '/builds/slave/test', 03:10:28 INFO - 'SHELL': '/bin/bash', 03:10:28 INFO - 'SHLVL': '1', 03:10:28 INFO - 'TERM': 'linux', 03:10:28 INFO - 'TMOUT': '86400', 03:10:28 INFO - 'USER': 'cltbld', 03:10:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:28 INFO - '_': '/tools/buildbot/bin/python'} 03:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:29 INFO - Downloading/unpacking jsonschema==2.5.1 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:31 INFO - warning: no files found matching '*.txt' 03:10:31 INFO - no previously-included directories found matching 'build' 03:10:31 INFO - no previously-included directories found matching 'dist' 03:10:31 INFO - no previously-included directories found matching '.git*' 03:10:31 INFO - Installing collected packages: jsonschema, functools32 03:10:31 INFO - Running setup.py install for functools32 03:10:31 INFO - warning: no files found matching '*.txt' 03:10:31 INFO - no previously-included directories found matching 'build' 03:10:31 INFO - no previously-included directories found matching 'dist' 03:10:31 INFO - no previously-included directories found matching '.git*' 03:10:31 INFO - Successfully installed jsonschema functools32 03:10:31 INFO - Cleaning up... 03:10:31 INFO - Return code: 0 03:10:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:10:31 INFO - Using env: {'DISPLAY': ':0', 03:10:31 INFO - 'HOME': '/home/cltbld', 03:10:31 INFO - 'LANG': 'en_US.UTF-8', 03:10:31 INFO - 'LANGUAGE': 'en_US:en', 03:10:31 INFO - 'LOGNAME': 'cltbld', 03:10:31 INFO - 'MAIL': '/var/mail/cltbld', 03:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:31 INFO - 'MOZ_NO_REMOTE': '1', 03:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:31 INFO - 'NO_EM_RESTART': '1', 03:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:31 INFO - 'PWD': '/builds/slave/test', 03:10:31 INFO - 'SHELL': '/bin/bash', 03:10:31 INFO - 'SHLVL': '1', 03:10:31 INFO - 'TERM': 'linux', 03:10:31 INFO - 'TMOUT': '86400', 03:10:31 INFO - 'USER': 'cltbld', 03:10:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:31 INFO - '_': '/tools/buildbot/bin/python'} 03:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:10:31 INFO - Cleaning up... 03:10:31 INFO - Return code: 0 03:10:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:10:31 INFO - Using env: {'DISPLAY': ':0', 03:10:31 INFO - 'HOME': '/home/cltbld', 03:10:31 INFO - 'LANG': 'en_US.UTF-8', 03:10:31 INFO - 'LANGUAGE': 'en_US:en', 03:10:31 INFO - 'LOGNAME': 'cltbld', 03:10:31 INFO - 'MAIL': '/var/mail/cltbld', 03:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:31 INFO - 'MOZ_NO_REMOTE': '1', 03:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:31 INFO - 'NO_EM_RESTART': '1', 03:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:31 INFO - 'PWD': '/builds/slave/test', 03:10:31 INFO - 'SHELL': '/bin/bash', 03:10:31 INFO - 'SHLVL': '1', 03:10:31 INFO - 'TERM': 'linux', 03:10:31 INFO - 'TMOUT': '86400', 03:10:31 INFO - 'USER': 'cltbld', 03:10:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:31 INFO - '_': '/tools/buildbot/bin/python'} 03:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:34 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 03:10:34 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 03:10:34 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 03:10:34 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 03:10:34 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 03:10:34 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 03:10:34 INFO - Downloading docopt-0.6.1.tar.gz 03:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:34 INFO - Running setup.py install for blobuploader 03:10:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:34 INFO - Running setup.py install for requests 03:10:35 INFO - Running setup.py install for docopt 03:10:35 INFO - Successfully installed blobuploader requests docopt 03:10:35 INFO - Cleaning up... 03:10:35 INFO - Return code: 0 03:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:35 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:35 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 03:10:35 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 03:10:35 INFO - Using env: {'DISPLAY': ':0', 03:10:35 INFO - 'HOME': '/home/cltbld', 03:10:35 INFO - 'LANG': 'en_US.UTF-8', 03:10:35 INFO - 'LANGUAGE': 'en_US:en', 03:10:35 INFO - 'LOGNAME': 'cltbld', 03:10:35 INFO - 'MAIL': '/var/mail/cltbld', 03:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:35 INFO - 'MOZ_NO_REMOTE': '1', 03:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:35 INFO - 'NO_EM_RESTART': '1', 03:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:35 INFO - 'PWD': '/builds/slave/test', 03:10:35 INFO - 'SHELL': '/bin/bash', 03:10:35 INFO - 'SHLVL': '1', 03:10:35 INFO - 'TERM': 'linux', 03:10:35 INFO - 'TMOUT': '86400', 03:10:35 INFO - 'USER': 'cltbld', 03:10:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:35 INFO - '_': '/tools/buildbot/bin/python'} 03:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:35 INFO - Running setup.py (path:/tmp/pip-dcDvlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:35 INFO - Running setup.py (path:/tmp/pip-RX8MAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:35 INFO - Running setup.py (path:/tmp/pip-r3CLqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:35 INFO - Running setup.py (path:/tmp/pip-2hOCHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:35 INFO - Running setup.py (path:/tmp/pip-Z96s5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:35 INFO - Running setup.py (path:/tmp/pip-KvC80e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:35 INFO - Running setup.py (path:/tmp/pip-dnMXkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:35 INFO - Running setup.py (path:/tmp/pip-5CrFLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:36 INFO - Running setup.py (path:/tmp/pip-nxIjob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:36 INFO - Running setup.py (path:/tmp/pip-U3b0VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:36 INFO - Running setup.py (path:/tmp/pip-BMceJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:36 INFO - Running setup.py (path:/tmp/pip-D6Qe29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:36 INFO - Running setup.py (path:/tmp/pip-wE2BJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:36 INFO - Running setup.py (path:/tmp/pip-heZg6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:36 INFO - Running setup.py (path:/tmp/pip-bioQZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:36 INFO - Running setup.py (path:/tmp/pip-iqOWCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:36 INFO - Running setup.py (path:/tmp/pip-9rLJJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:36 INFO - Running setup.py install for manifestparser 03:10:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:36 INFO - Running setup.py install for mozcrash 03:10:36 INFO - Running setup.py install for mozdebug 03:10:36 INFO - Running setup.py install for mozdevice 03:10:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozfile 03:10:37 INFO - Running setup.py install for mozhttpd 03:10:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozinfo 03:10:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozInstall 03:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozleak 03:10:37 INFO - Running setup.py install for mozlog 03:10:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for moznetwork 03:10:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozprocess 03:10:37 INFO - Running setup.py install for mozprofile 03:10:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Running setup.py install for mozrunner 03:10:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Running setup.py install for mozscreenshot 03:10:38 INFO - Running setup.py install for moztest 03:10:38 INFO - Running setup.py install for mozversion 03:10:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:38 INFO - Cleaning up... 03:10:38 INFO - Return code: 0 03:10:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:38 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:38 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 03:10:38 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 03:10:38 INFO - Using env: {'DISPLAY': ':0', 03:10:38 INFO - 'HOME': '/home/cltbld', 03:10:38 INFO - 'LANG': 'en_US.UTF-8', 03:10:38 INFO - 'LANGUAGE': 'en_US:en', 03:10:38 INFO - 'LOGNAME': 'cltbld', 03:10:38 INFO - 'MAIL': '/var/mail/cltbld', 03:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:38 INFO - 'MOZ_NO_REMOTE': '1', 03:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:38 INFO - 'NO_EM_RESTART': '1', 03:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:38 INFO - 'PWD': '/builds/slave/test', 03:10:38 INFO - 'SHELL': '/bin/bash', 03:10:38 INFO - 'SHLVL': '1', 03:10:38 INFO - 'TERM': 'linux', 03:10:38 INFO - 'TMOUT': '86400', 03:10:38 INFO - 'USER': 'cltbld', 03:10:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:38 INFO - '_': '/tools/buildbot/bin/python'} 03:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:38 INFO - Running setup.py (path:/tmp/pip-t7JH4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:38 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)) 03:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:38 INFO - Running setup.py (path:/tmp/pip-sLKYPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:38 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)) 03:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:38 INFO - Running setup.py (path:/tmp/pip-Z0Aa94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:38 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)) 03:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:38 INFO - Running setup.py (path:/tmp/pip-doZGFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:38 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)) 03:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:38 INFO - Running setup.py (path:/tmp/pip-zeQUNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:39 INFO - Running setup.py (path:/tmp/pip-VHg_HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:39 INFO - Running setup.py (path:/tmp/pip-cVCh2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:39 INFO - Running setup.py (path:/tmp/pip-ZlJkmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:39 INFO - Running setup.py (path:/tmp/pip-i5z0JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:39 INFO - Running setup.py (path:/tmp/pip-jjpjrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:39 INFO - Running setup.py (path:/tmp/pip-bH06TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:39 INFO - Running setup.py (path:/tmp/pip-XcdNyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:39 INFO - Running setup.py (path:/tmp/pip-mOx2RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:39 INFO - Running setup.py (path:/tmp/pip-PP08LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:39 INFO - Running setup.py (path:/tmp/pip-9PUfdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:39 INFO - Running setup.py (path:/tmp/pip-LDRgMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:39 INFO - Running setup.py (path:/tmp/pip-dJDEWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:39 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)) 03:10:39 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)) 03:10:39 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)) 03:10:39 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)) 03:10:39 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)) 03:10:39 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)) 03:10:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:39 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 03:10:39 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 03:10:39 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 03:10:39 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 03:10:39 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 03:10:39 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 03:10:41 INFO - Downloading blessings-1.6.tar.gz 03:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:42 INFO - Installing collected packages: blessings 03:10:42 INFO - Running setup.py install for blessings 03:10:42 INFO - Successfully installed blessings 03:10:42 INFO - Cleaning up... 03:10:42 INFO - Return code: 0 03:10:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:42 INFO - Reading from file tmpfile_stdout 03:10:42 INFO - Current package versions: 03:10:42 INFO - argparse == 1.2.1 03:10:42 INFO - blessings == 1.6 03:10:42 INFO - blobuploader == 1.2.4 03:10:42 INFO - docopt == 0.6.1 03:10:42 INFO - functools32 == 3.2.3-2 03:10:42 INFO - jsonschema == 2.5.1 03:10:42 INFO - manifestparser == 1.1 03:10:42 INFO - mozInstall == 1.12 03:10:42 INFO - mozcrash == 0.17 03:10:42 INFO - mozdebug == 0.1 03:10:42 INFO - mozdevice == 0.48 03:10:42 INFO - mozfile == 1.2 03:10:42 INFO - mozhttpd == 0.7 03:10:42 INFO - mozinfo == 0.9 03:10:42 INFO - mozleak == 0.1 03:10:42 INFO - mozlog == 3.3 03:10:42 INFO - moznetwork == 0.27 03:10:42 INFO - mozprocess == 0.23 03:10:42 INFO - mozprofile == 0.28 03:10:42 INFO - mozrunner == 6.12 03:10:42 INFO - mozscreenshot == 0.1 03:10:42 INFO - mozsystemmonitor == 0.3 03:10:42 INFO - moztest == 0.7 03:10:42 INFO - mozversion == 1.4 03:10:42 INFO - psutil == 3.1.1 03:10:42 INFO - requests == 1.2.3 03:10:42 INFO - wsgiref == 0.1.2 03:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:42 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')]} 03:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:42 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')]} 03:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:42 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:42 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 03:10:42 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 03:10:42 INFO - Using env: {'DISPLAY': ':0', 03:10:42 INFO - 'HOME': '/home/cltbld', 03:10:42 INFO - 'LANG': 'en_US.UTF-8', 03:10:42 INFO - 'LANGUAGE': 'en_US:en', 03:10:42 INFO - 'LOGNAME': 'cltbld', 03:10:42 INFO - 'MAIL': '/var/mail/cltbld', 03:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:42 INFO - 'MOZ_NO_REMOTE': '1', 03:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:42 INFO - 'NO_EM_RESTART': '1', 03:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:42 INFO - 'PWD': '/builds/slave/test', 03:10:42 INFO - 'SHELL': '/bin/bash', 03:10:42 INFO - 'SHLVL': '1', 03:10:42 INFO - 'TERM': 'linux', 03:10:42 INFO - 'TMOUT': '86400', 03:10:42 INFO - 'USER': 'cltbld', 03:10:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:42 INFO - '_': '/tools/buildbot/bin/python'} 03:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 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)) 03:10:42 INFO - Cleaning up... 03:10:42 INFO - Return code: 0 03:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:42 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')]} 03:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:42 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')]} 03:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:42 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 0x2445030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, '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': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', '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 03:10:42 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 03:10:42 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 03:10:42 INFO - Using env: {'DISPLAY': ':0', 03:10:42 INFO - 'HOME': '/home/cltbld', 03:10:42 INFO - 'LANG': 'en_US.UTF-8', 03:10:42 INFO - 'LANGUAGE': 'en_US:en', 03:10:42 INFO - 'LOGNAME': 'cltbld', 03:10:42 INFO - 'MAIL': '/var/mail/cltbld', 03:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:42 INFO - 'MOZ_NO_REMOTE': '1', 03:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:42 INFO - 'NO_EM_RESTART': '1', 03:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:42 INFO - 'PWD': '/builds/slave/test', 03:10:42 INFO - 'SHELL': '/bin/bash', 03:10:42 INFO - 'SHLVL': '1', 03:10:42 INFO - 'TERM': 'linux', 03:10:42 INFO - 'TMOUT': '86400', 03:10:42 INFO - 'USER': 'cltbld', 03:10:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:42 INFO - '_': '/tools/buildbot/bin/python'} 03:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:42 INFO - Cleaning up... 03:10:42 INFO - Return code: 0 03:10:42 INFO - Running post-action listener: _resource_record_post_action 03:10:42 INFO - Running post-action listener: _start_resource_monitoring 03:10:42 INFO - Starting resource monitoring. 03:10:42 INFO - [mozharness: 2016-07-27 10:10:42.881844Z] Finished create-virtualenv step (success) 03:10:42 INFO - [mozharness: 2016-07-27 10:10:42.882802Z] Running install step. 03:10:42 INFO - Running pre-action listener: _resource_record_pre_action 03:10:42 INFO - Running main action method: install 03:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:43 INFO - Reading from file tmpfile_stdout 03:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:43 INFO - Reading from file tmpfile_stdout 03:10:43 INFO - Output received: 03:10:43 INFO - Usage: mozinstall [options] installer 03:10:43 INFO - Options: 03:10:43 INFO - -h, --help show this help message and exit 03:10:43 INFO - -d DEST, --destination=DEST 03:10:43 INFO - Directory to install application into. [default: 03:10:43 INFO - "/builds/slave/test"] 03:10:43 INFO - --app=APP Application being installed. [default: firefox] 03:10:43 INFO - mkdir: /builds/slave/test/build/application 03:10:43 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'] 03:10:43 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 03:10:59 INFO - Reading from file tmpfile_stdout 03:10:59 INFO - Output received: 03:10:59 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:59 INFO - Running post-action listener: _resource_record_post_action 03:10:59 INFO - [mozharness: 2016-07-27 10:10:59.536502Z] Finished install step (success) 03:10:59 INFO - [mozharness: 2016-07-27 10:10:59.536778Z] Running run-tests step. 03:10:59 INFO - Running pre-action listener: _resource_record_pre_action 03:10:59 INFO - Running main action method: run_tests 03:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:59 INFO - Python 2.7.3 03:10:59 INFO - Return code: 0 03:10:59 INFO - grabbing minidump binary from tooltool 03:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:59 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 0x27043b0>, '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 0x27052b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2705740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:59 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 03:10:59 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 03:10:59 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 03:11:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:00 INFO - Return code: 0 03:11:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:11:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:11:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:11:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:11:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 03:11:00 INFO - Using env: {'DISPLAY': ':0', 03:11:00 INFO - 'HOME': '/home/cltbld', 03:11:00 INFO - 'LANG': 'en_US.UTF-8', 03:11:00 INFO - 'LANGUAGE': 'en_US:en', 03:11:00 INFO - 'LOGNAME': 'cltbld', 03:11:00 INFO - 'MAIL': '/var/mail/cltbld', 03:11:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:11:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:00 INFO - 'MOZ_NO_REMOTE': '1', 03:11:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:00 INFO - 'NO_EM_RESTART': '1', 03:11:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:00 INFO - 'PWD': '/builds/slave/test', 03:11:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:11:00 INFO - 'SHELL': '/bin/bash', 03:11:00 INFO - 'SHLVL': '1', 03:11:00 INFO - 'TERM': 'linux', 03:11:00 INFO - 'TMOUT': '86400', 03:11:00 INFO - 'USER': 'cltbld', 03:11:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852', 03:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:00 INFO - '_': '/tools/buildbot/bin/python'} 03:11:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:11:01 INFO - mozversion application_buildid: 20160727023615 03:11:01 INFO - mozversion application_changeset: 96de0b18cace15865b2d013110e9c70aa7d9d6d8 03:11:01 INFO - mozversion application_display_name: Nightly 03:11:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:01 INFO - mozversion application_name: Firefox 03:11:01 INFO - mozversion application_remotingname: firefox 03:11:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:11:01 INFO - mozversion application_vendor: Mozilla 03:11:01 INFO - mozversion application_version: 50.0a1 03:11:01 INFO - mozversion platform_buildid: 20160727023615 03:11:01 INFO - mozversion platform_changeset: 96de0b18cace15865b2d013110e9c70aa7d9d6d8 03:11:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:11:01 INFO - mozversion platform_version: 50.0a1 03:11:01 INFO - using testdate: 1469614261 03:11:01 INFO - actual date: 1469614261 03:11:01 INFO - starting webserver on 'localhost:45419' 03:11:01 INFO - SUITE-START | Running 2 tests 03:11:01 INFO - TEST-START | dromaeo_css 03:11:01 INFO - operating with platform_type : linux_ 03:11:01 INFO - Initialising browser for dromaeo_css test... 03:11:02 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQUvou/profile http://localhost:45419/getInfo.html) 03:11:11 INFO - PROCESS | 3315 | JavaScript error: , line 0: uncaught exception: undefined 03:11:12 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 03:11:12 INFO - PROCESS | 3315 | colorDepth:24 03:11:12 INFO - PROCESS | 3315 | Browser inner width/height: 1024/697 03:11:12 INFO - PROCESS | 3315 | __metrics 03:11:13 INFO - PROCESS | 3315 | 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" 03:11:13 INFO - PROCESS | 3315 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:11:14 INFO - PROCESS | 3315 | console.error: PushService: 03:11:14 INFO - PROCESS | 3315 | stateChangeProcessEnqueue: Error transitioning state 03:11:14 INFO - PROCESS | 3315 | UnknownError 03:11:14 INFO - TEST-INFO | 3315: exit 0 03:11:14 INFO - Browser initialized. 03:11:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:11:14 INFO - TEST-INFO | started process 3395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQUvou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:26 INFO - PROCESS | 3395 | RSS: Main: 159473664 03:11:26 INFO - PROCESS | 3395 | 03:12:18 INFO - PROCESS | 3395 | 1469614338605 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] 03:14:31 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45419/tests/dromaeo/cssquery-ext.html) 03:14:32 INFO - PROCESS | 3395 | RSS: Main: 244264960 03:14:32 INFO - PROCESS | 3395 | 03:17:35 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-ext.html (next: http://localhost:45419/tests/dromaeo/cssquery-jquery.html) 03:17:35 INFO - PROCESS | 3395 | RSS: Main: 240783360 03:17:35 INFO - PROCESS | 3395 | 03:20:37 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45419/tests/dromaeo/cssquery-mootools.html) 03:20:38 INFO - PROCESS | 3395 | RSS: Main: 192131072 03:20:38 INFO - PROCESS | 3395 | 03:23:40 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45419/tests/dromaeo/cssquery-prototype.html) 03:23:41 INFO - PROCESS | 3395 | RSS: Main: 194768896 03:23:41 INFO - PROCESS | 3395 | 03:26:44 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45419/tests/dromaeo/cssquery-yui.html) 03:26:44 INFO - PROCESS | 3395 | RSS: Main: 192827392 03:26:44 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | Cycle 1(1): loaded http://localhost:45419/tests/dromaeo/cssquery-yui.html (next: http://localhost:45419/tests/dromaeo/cssquery-dojo.html) 03:29:47 INFO - PROCESS | 3395 | RSS: Main: 283389952 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | __start_tp_report 03:29:47 INFO - PROCESS | 3395 | _x_x_mozilla_page_load 03:29:47 INFO - PROCESS | 3395 | _x_x_mozilla_page_load_details 03:29:47 INFO - PROCESS | 3395 | |i|pagename|runs| 03:29:47 INFO - PROCESS | 3395 | |0;dojo.html;2635.9472810543803;2658.6809582850055;2667;2671.9198424047286;2675.9063432779844;4620;4675.392199014132;4682.180618391781;4774.809007639695;4808.230683090702;4672.415948006499;4700.576948074672;4770.7853146608395;4812.663113582051;4819.0843739689435;4266.296061149907;4278.700490965633;4339.826406943718;4390.143921935224;4480.23835947888;4399.538048504893;4436.068425630621;4444.555544445562;4451.688381813275;4453.821847126111;4304.053108316165;4342.652587792969;4348.630366418858;4403.581659742319;4408.316710909814;4306.504751953503;4357.3899654048455;4382.517923028464;4413.051193993307;4421.049474363027;4311.784410779448;4318.805653745558;4327.545607711208;4371.213181627306;4400.581944715247;4730.526947305242;4751.121042607128;4787.40157480315;4797.832075877328;4798.0643774464;4840.540148685905;5040.319556859814;5085.974570127163;5094.821681241176;5107.923381149286;5115.411727651331;5164.302819119446;5167.147420675584;5174.922376164361;5179.430262671103;4754.5007774183905;4770.308305295713;4794.113089078532;4807.206810876236;4807.711537307773;5028.522290382481;5044.243363495431;5128.589712822965;5146.6911985281;5184.040952423814;4985.800567977313;4990.226514890198;5030.170021946338;5036.345275114211;5036.521530454601;5077;5086.54221120101;5117.513836185556;5129.410117836496;5136.409312929061;4915.336429581961;4984.601231901439;5004.049230646166;5031.0441016206805;5033.723145227048;5007.624428167902;5019.196928491424;5021.698698078127;5022.89954200914;5054.393472783289;4243.851465198765;4245.57544245573;4256.425382573375;4280.165367753259;4285.121550082225;3686.4286035664513;3713.9814300928865;3720.516332876709;3721.5162028936606;3744.3634582121103;4397.648188144941;4413.249747542925;4440.156370289635;4461.866144015685;4463.2635615123145;5064.366954130734;5068.949310506921;5072.036313100499;5079.6952182869145;5084.974575127175;4307.547707490731;4386.4736231652405;4389.780510974439;4398.472183337956;4436.711613745097;4561.201789686792;4571.657125715585;4604.470485894098;4623.398958135488;4623.606993405599;4793.209120495079;4794.760261986957;4802.471728109975;4804.495527969652;4848.175810112219;4957.727324997016;5012.573931215888;5061.670991385696;5071.822486212965;5101.056304583664;4813.9037219256115;4829.348038014823;4829.95170048295;4861.611071114373;4878.975605122094;5045.167547354646;5049.419316778471;5051.166557517969;5053.115704751727;5095.974520127375;4937.679050861682;5061.822836200715;5071.822486212965;5097.08252514551;5142.794288228429;5013.2981382607195;5017;5021.949780502148;5045.192769156917;5052.292679024866;4988.251762235694;4992.226204938241;5000.699958002531;5004.099262132705;5048.949510504995;4738.857834264978;4765.880852978703;4795.424549053996;4939.851804445872;5002.374703162105;4943.085529177114;4945.035718035093;4955;4963.900721985612;4984.02811451778;4867.926981095357;4873.561379475864;4874.439439464365;4883.218685010382;4927.950720492892 03:29:47 INFO - PROCESS | 3395 | |1;ext.html;572.8081092833901;574.3968832725637;586.2173997713054;586.6802592587039;586.8151532267339;26757.866210668944;39573.208535829304;40591.59408405915;40733;44899;40828.59171408285;41170.38244426328;41260;41370.58629413705;41390.58609413912;7668.654910529026;7771.290316130442;7799.844003119934;7812.375009999215;7813.765587032398;7354.448416368767;9631.27765417593;9886.851697224547;9893.30746847721;10230.130438912664;10060.446675432848;10063.496825158749;10138.341007834504;10162.18702503798;10162.18702503798;9852.359596626233;9873.506324683736;9891.35706179096;9900.90099099007;9905.554250058765;9790.9510452448;9826.16477599405;9860.30977831552;9880.258980576486;9903.504824758733;38369.61630383688;38533.22933541313;38573;38596.228075438616;38768.61231387678;2659.095907391477;2809.4100238949845;2855.6858745537975;2991.311998240417;3441.9827900860337;28978.71021289781;29117.85441072781;29261.853690731623;29452;29708.70291297081;3001.6998300170026;3023.9244018899703;3030.5151175811984;3042.2242328206166;3061.280599059219;264974;267544.9999999981;269992;270010;271533;31515.21211969719;54366.45633543693;54906;54909.450905490434;54927;28089.157325280274;29573.112806615834;29581.408371832444;29598.704012960025;29620.703792962224;12458.75082498363;12584.685382865502;12587.937060314824;12589.622311330675;12592.307423091817;9398.436093834393;9684.370515916584;10090.49547522621;10145.442000690033;10155.847662285072;7645.923540764632;7722.884156737653;7827.530348179127;7863.292303692695;7878.763637090897;3013.758899288052;3038.194878357193;3074.400491904102;3078.2150551609197;3090.5518699788404;827.4580150001758;841.4993079117914;844.5903736687701;848.1433751910615;850.1583432402001;25964.480710386066;27133.457330853667;27605.447891042066;27694.861525692242;27939;867.6399294292924;892.3887137310962;892.7991201979503;932.1383353105899;967.7919247361851;14277.500287489887;14364.35360408784;14609.831213502894;14687.77968330476;14881.404743810343;393095;395354.1161470986;397602;398244;399993;48163.27755083676;48793.268100978516;48823.511764882605;48854.75572622114;49011.75494122507;1061.4851796878509;1132.3432409202642;1183.4556104191995;1193.9223950443193;1205.9939700301443;27536.44927101487;28769.712302876702;29032;29236.678107611675;29539.261518462212;40927.18145637011;41587.58412415837;41590;41607.79196104;41701.582984170986;317337;318335;318388;319135;319325;24631.87684061568;25687.357816054748;25690.486190275715;26518.60222096709;26710.866445668424;40728.79635601803;41324;41445.585544144174;41504.169916602106;41545.169096618505;34464.138396540286;34642;34881;35288.47067294044;35556.82221588876;35010.474842877884;35338;35609.82195089111;35756;36054;34766.65233347634;35106.12234694153;35266.471002934464;35328.29343413169;36130;30481;32556.837215813768;32725.836370817993;32792;32823.83588082044;24290.51418971646;24761.62857557174;24891.128810491547;25111.24666260015;25245.495090097727 03:29:47 INFO - PROCESS | 3395 | |2;jquery.html;348.56951664694117;369.86499927526444;374.5355758859015;376.95476542814856;388.6696308138083;12857.421416036277;16242.269097890594;16735.497935061954;17083.316667333293;18232.908835455837;15583.688326233498;16056.83943160568;16098.356065757385;16219.189040547984;16318.918405407985;4677.695949763263;5055.3933527976515;5151.81968631098;5395.73021348933;5435.456454354572;3507.5615548056494;5161.27742116104;5457.208704737831;5487.506124448799;5487.6158668892995;5343.251944727741;5427.104527752916;5442.727863606824;5446.373667028283;5471.151971444432;5265.4997775211295;5383.057964856134;5416.458354164592;5425.7287135643255;5450.264214331054;5263.210518422229;5269.762860671241;5270.051390749663;5270.367555893279;5273.920891186635;12595.3072581008;17704.937703737687;18912.62174756511;21398.679019814714;21543.784562154335;1730.6625208084429;1788.9821101789075;1795.1024487756122;1806.9277228910828;1911.9426417207505;9110.86333704995;9215.216706579882;9551.283653725928;9749.463779492125;12844.550440734529;1661.0448991829746;1722.9741553876702;1731.2382551677222;1764.408923010793;1825.2334019711752;71687;73703.26296737017;75603.62198189029;76303.23696763073;76926;9827.705168844946;9985.851627062835;10024.749381265527;10043.598256069676;10163.18694504438;14177.858221417653;14223.92888035574;14238.074525156038;14280.928595356956;14286.42854285817;6784;6865.210500792373;6943.9652801735665;7012.333828286304;7086.362227399559;6318.147050148263;6361.363863613602;6516.57642253252;6517.087607734921;6522.869542609121;4188.602082802129;4283.850065247701;4306.20335237982;4440.933385999213;4454.331850222493;1712.6831536165848;1801.1174524483172;1814.7005744052346;1816.8546516278666;1861.8231268029515;765.8430021845509;787.9054513458422;811.3184924663311;853.1681610429905;900.104396125859;16746.162691865356;17052.744208836877;17811.287548497916;17814.287428502976;18021.549461263574;804.3002587748696;825.0800357601352;845.1168528887328;879.2174964281794;886.5567216391804;8863.113688631085;9209.257232525255;9309.255259579217;9683.757906052264;9902.356346837576;404560;415204;416760;416796;417200;85380.57309713411;87868;88059.55970220236;88240;88732;889.9510526920952;908.327837400319;930.432436213909;932.9253659707207;933.0389698610442;14059.859401405854;14893.47872824446;15316.693666126837;15359.923200383926;15389.307481163598;38009.61990380061;38044.80977595094;38371.80814095912;39480.2103957925;39917.600823991386;55310.44689553214;55406.16890746562;56602.15096773634;56644.433555665564;56780.148297776395;4933.531314525115;6455.677216139268;7613.961930190314;7656.349210317186;7962.402819788424;9897.50512474359;11432.428378580871;11677.357745324089;11724.58963936258;11770.3526306054;9467.100625440573;9594;9661.420314781135;9761.316707830383;10004.84992725095;4625.07498500308;7101.899205623136;9311;10229.43738094412;10471.3193642413;8822;9729.951350243487;9886.209103271578;10047.397156170653;10246.948765256126;7455.888161677471;7536.359409450039;7581.772546823604;7677.193894640982;7772.611369431619;9003.54982250898;9880.654177103766;9943.602255909971;9982.800343992934;10325.070743633109 03:29:47 INFO - PROCESS | 3395 | |3;mootools.html;1213.0780606738876;1302.8241187439694;1345.8115863779071;1353.3706826325756;1634.8283430239824;6618.470522358211;7667.118281397641;7921.366290696745;7926.762197134095;8158.632861521231;7928.127905930343;7953.681852725898;7956.562389068599;7970.286388426487;7994.400419968511;2222.8555143915632;2247.6965609642734;2252.200468833565;2252.7747225277503;2252.8648281103106;2183.224955140926;2224.7997680208778;2235.776422357759;2242.495438526335;2245.7305123385136;2174.315090746418;2217.7227846519186;2227.120287486442;2228.2535350657467;2230.02993697742;2162.610730068587;2179.8256139508803;2181.5964046651343;2190.496185877257;2195.4401627584944;2151.752548456932;2156.2884248198056;2156.870587764739;2157.0508976050646;2157.4174972757423;7813.765587032398;7908.683652653887;7908.762737117896;7944.364450843918;7975.282224599814;4369.322754972953;4561.1105834362315;4563.699345686497;4565.771711414416;4573.0396616710195;2740.986295068532;2875.1374587623627;2926.590277361171;2940.5442156465783;2941.911742647724;900.3292547052422;903.9502827344494;920.3327587499076;926.1386910173536;933.4352716606492;10734.194935379799;10823.296485728402;10828;10836.349819010884;10873;3827.6363745444137;4023.114914718757;4139.4204811326435;4182.64447521964;4185.016521117535;8341.5412152331;8363.163683631588;8386;8430.072692003874;8447.873281900776;4424.446944131983;4444.622207112432;4454.643628509712;4460.28635418338;4462.062966776948;3625.8912232633065;3954.7824869632445;4121.113960498507;4137.689673274516;4139.4204811326435;3377.2401209728105;3404.14896275931;3490.1798077451776;3495.3708332500396;3606.747527673038;1011.726833754882;1045.0490054050777;1052.1162223732101;1057;1068.6687126990657;780.6526095887276;789.06889869954;789.6920201121567;804.7666176808777;830.4270053662954;5135.743212839343;5151.5621172200035;5315.3621565412395;5338.3060202173465;5349.919751203735;389.1302937933716;403.5984195725213;407.1368698359497;409.43089106142486;414.834066373447;3545.6808887200277;3584.4981702561663;3613.9819300903855;3649.1789347397153;3689.815509224528;9484.146426821619;9965.900340996643;9977.850332245021;9978.550965206583;9984.051515106054;9988.25088118394;9989.250806189564;9998.550065247082;10009.449480278508;10031.899681003242;7410.925890741131;7489.101307843093;7496.7750967471065;7498.887516687254;7506.587137707478;5365.946340536545;5502.064649009758;5613.691246981455;5669.659820410624;5772.047612144117;8903.465792052497;9071.637134514545;9316.813663726824;9332.766680833034;9338.439693618404;9001.459912405277;9055.68305109318;9161.541922903962;9184.357095003286;9348.345615806827;7042.894356584553;7126.073610430611;7175.820604484929;7305.853882922418;7411.4070874331;7295.088113985752;7367.815804604714;7382.151052629017;7383.261673832574;7397.26027397256;6579.2104947406615;6625.966870165618;6670.966645166744;6697.0958920547055;6979.057827193467;6597.0764093026055;6619.933800661932;6632.701528431328;6637.2699003108655;6768.661566921733;6084.330723620486;6160.260768707604;6161.784337548164;6165.475934545434;6170.321264660974;4526.388937493396;4612.654050946126;4624.352590637381;4695.460022097366;4708.623310135249;4496.190685676479;4518.683692141519;4533.909321813611;4612.30815377696;4710.576048155683 03:29:47 INFO - PROCESS | 3395 | |4;prototype.html;304.775989647609;305.36179385085165;313.451459945096;315.7379375118652;317.8251961421219;4778.569928706415;4845.733484658343;4933.3586633737605;4968.478309777475;4973.151177601841;4682.461516925555;4828.613710903128;4839.05638400512;4851.466338702739;4856.611471082314;3876.3604005339084;3876.592957739439;3890.5525864525657;3899.4345819856103;3900.7074469414765;3624.9456258156147;3652.8904132876055;3867.3038853006447;3884.6309600587897;3896.590857959916;3844.2888065707934;3857.0935830079907;3857.0935830080048;3859.3439115350316;3871.264459752652;3842.098161410092;3845.673242731253;3846.6345697158727;3849.8652547160996;3853.6531712146043;3399.4051041067714;3399.8980030599123;3404.6595340465756;3417.2652879631;3423.9144021399416;4573.428321459817;4666.300054991744;4705.811767529295;4734.83428080019;4745.098431298043;4377.846775362879;4392.472903251598;4400.11997600478;4402.955970440286;4406.405135306724;5052.1411360068505;5059.355709394462;5069.366329208849;5093.446498817859;5105.03004429161;3624.746267761258;3717.75834570752;3724.7951362675044;3733.0667333166707;3737.0283726231105;5271.551918086967;5277.920831187497;5308.309919710451;5320.627556071038;5321.627486076015;3817.84728610858;3818.961810381916;3824.78963656996;3826.693864490834;3830.9808450958126;3751.8311675974646;3874.6319099685484;3875.2636998970106;3891.630295121959;3894.5521265054313;4260.659147268211;4278.700490965664;4282.164977829293;4285.571442855752;4308.6983911126545;5027.79888804451;5030.170021946338;5032.421271553745;5033.949660503348;5087.753500392353;1265.4432049898016;1302.856685764565;1321.1346567997978;1332.840059192903;1333.9733205336033;842.3135144857044;856.5802756649197;860.875173099897;863.3826813828143;865.1089377940731;4018.236535058388;4045.6561192298395;4064.878053658395;4079.0822065035723;4159.875203743893;4547.1815073287125;4563.54364563541;4573.536468330169;4593.839215627437;4650.00024994621;4018.8794336169963;4024.91950161001;4042.8989275268355;4057.776822274744;4062.9593704063172;2350.9647355289685;2423.6243382275775;2436.317831007321;2444.985331087614;2459.9016039358585;4333.458317710286;4354.782260886943;4382.846600368972;4388.2759344707765;4390.209762242827;4694.319323698045;4720.929186062212;4726.26742854858;4766.809327626926;4807.495213002654;4063.938504625565;4375.812093953024;4401.603855653007;4413.713108647928;4426.915405725682;4574.7255164688895;4579.335996280454;4583.54164583539;4626.606738427271;4630.259158534618;4512.548745125461;4521.186186486464;4537.636989040935;4594.356790049463;4624.982503849148;4065.484581935113;4373.562643735601;4376.862015875831;4381.693281470267;4389.924468505236;3426.0471531226963;3448.4827275908815;3459.4605400597497;3477.8434970425888;3481.3559491494157;4641.489436161952;4648.558386953234;4669.766511674471;4699.53004699541;4710.952890471051;4934.9753251233515;5032.572231360229;5075.365579302587;5083.364579427572;5091.643584949018;4470.173017991682;4971.825986090469;5063.240513922941;5077.77150028257;5083.237514372874;5035.086667066637;5042.268871013609;5058.519440653132;5062.190049592047;5068.974655126701;5048.396658314125;5178.741062946913;5191.299174611379;5192.221166825007;5195.9740201298755;4930.137225985366;4960.627952903475;4991.750412479434;4998.525140111684;5002.949970500394 03:29:47 INFO - PROCESS | 3395 | |5;yui.html;617.5245061302796;652.8400541867246;672.7914346552573;727.3998950865534;736.6979538389262;11548.3071015739;12154.39228038599;12169.817452738216;12187.756244875098;12188.51245950162;12118.272903625788;12210.32843193624;12212.084093692964;12250.387480625956;12259.693507662312;620.7237779188263;747.428217413679;750.2160242546538;769.5498133591856;773.8490994256123;769.1347234361343;772.6059709548115;775.592813772771;776.3401109057285;776.763087258386;801.0147518552184;801.4550105927966;801.6432687454085;801.9879701804477;802.7350974178536;645.1290757477415;663.237277131298;664.4551467796409;664.7772996046331;803.907550631679;550.6723499517781;568.2442351672307;568.4798409455343;568.8037627018672;569.0411656359048;12524.874751252553;12525.624231273076;12540.686482838002;12541.933935615483;12567.937160314232;12308;12547.184433011826;12697.365131743376;13042.673933151653;13278.477089352991;11003.449827508673;11202.43987800615;11316.151288653302;11486.253393529478;11636.243644163102;3988.501437320335;4028.375601781699;4100.466939297902;4126.3397856343145;4141.544430112715;57055;57137.42862571404;57162.7141864288;57274.42725572733;57644.135337969965;9691.176250018827;9956.303058785816;10456.52945617449;10468.267221294589;10498.790024199474;18423.631527369376;18554.257829686932;18593;18663.626727465376;18679.159437825332;5986.700664966735;6057.151998720183;6064.818055458343;6068.8786224276155;6160.476359509492;3469.2020835208045;3522.3397548856456;3524.8766293179615;3542.0790594445116;3572.28554289138;2616.6467526884007;2718.1030260014545;2718.374773801997;2719.619253304539;2720.143154906198;456.61187990208055;460.10279954089657;461.7321953267164;471.73818530715783;478.58124141376294;461.4186125481917;467.18009892638884;514.6834696661526;529.8172130614931;547.8137433272707;6488.513361497907;6532.510061745388;6980.406665433394;7143.678534465961;7181.174164970991;441.58711604649113;510.2856001597793;513.7816428018077;521.072490966081;549.5136803928552;3128.1553980425156;3224.2261857154112;3302.1909632140278;3371.8482668279985;3411.1650824365015;54418.72790636022;55050;55217.72391138099;57426;100891;83060;83508.58245708732;84192;84426;87878.56060719784;73159.63420182865;75741.24258757452;77689.22310776933;77850;78157;6412.839679008062;6551.737930482727;6569.704363303567;6629.6685165740555;6682.699278532575;44746.12870010307;45750.77124614356;46667;46796;47894.5210547904;57940.71029644825;62689;65045.67477162584;65324.67337663281;67467.66266168638;8504.744857654281;8551.828963420821;8604.78488037804;8712.78218044554;8756.649734010569;8585.18440748128;8680.305575554066;8839.779005524657;8855.955720221615;8923.241524470493;7921.722739704082;8082.434229603871;8114.959425202836;8176.46852954556;8354.039285482248;8519.318454523747;8550.786230344042;8581.098984606526;8654.524001179996;8665.133486651284;8125.67497300125;8194.959025204837;8218.301444377055;8238.50568965864;8267.62795674184;7084.397826184832;7282.089738782653;7306.123265208209;7308.96345518269;7553.697852085855;7199.532030418006;7205.351518363373;7237.240089790496;7532.322091011835;7559.848803024019 03:29:47 INFO - PROCESS | 3395 | __end_tp_report 03:29:47 INFO - PROCESS | 3395 | __start_cc_report 03:29:47 INFO - PROCESS | 3395 | _x_x_mozilla_cycle_collect,916 03:29:47 INFO - PROCESS | 3395 | __end_cc_report 03:29:47 INFO - PROCESS | 3395 | __startTimestamp1469615387826__endTimestamp 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | ------- Summary: start ------- 03:29:47 INFO - PROCESS | 3395 | Number of tests: 6 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#0] dojo.html Cycles:165 Average:4697.49 Median:4819.08 stddev:491.64 (10.2%) stddev-sans-first:465.79 03:29:47 INFO - PROCESS | 3395 | Values: 2635.9 2658.7 2667.0 2671.9 2675.9 4620.0 4675.4 4682.2 4774.8 4808.2 4672.4 4700.6 4770.8 4812.7 4819.1 4266.3 4278.7 4339.8 4390.1 4480.2 4399.5 4436.1 4444.6 4451.7 4453.8 4304.1 4342.7 4348.6 4403.6 4408.3 4306.5 4357.4 4382.5 4413.1 4421.0 4311.8 4318.8 4327.5 4371.2 4400.6 4730.5 4751.1 4787.4 4797.8 4798.1 4840.5 5040.3 5086.0 5094.8 5107.9 5115.4 5164.3 5167.1 5174.9 5179.4 4754.5 4770.3 4794.1 4807.2 4807.7 5028.5 5044.2 5128.6 5146.7 5184.0 4985.8 4990.2 5030.2 5036.3 5036.5 5077.0 5086.5 5117.5 5129.4 5136.4 4915.3 4984.6 5004.0 5031.0 5033.7 5007.6 5019.2 5021.7 5022.9 5054.4 4243.9 4245.6 4256.4 4280.2 4285.1 3686.4 3714.0 3720.5 3721.5 3744.4 4397.6 4413.2 4440.2 4461.9 4463.3 5064.4 5068.9 5072.0 5079.7 5085.0 4307.5 4386.5 4389.8 4398.5 4436.7 4561.2 4571.7 4604.5 4623.4 4623.6 4793.2 4794.8 4802.5 4804.5 4848.2 4957.7 5012.6 5061.7 5071.8 5101.1 4813.9 4829.3 4830.0 4861.6 4879.0 5045.2 5049.4 5051.2 5053.1 5096.0 4937.7 5061.8 5071.8 5097.1 5142.8 5013.3 5017.0 5021.9 5045.2 5052.3 4988.3 4992.2 5000.7 5004.1 5048.9 4738.9 4765.9 4795.4 4939.9 5002.4 4943.1 4945.0 4955.0 4963.9 4984.0 4867.9 4873.6 4874.4 4883.2 4928.0 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#1] ext.html Cycles:180 Average:46999.46 Median:35058.30 stddev:87669.96 (250.1%) stddev-sans-first:87846.59 03:29:47 INFO - PROCESS | 3395 | Values: 572.8 574.4 586.2 586.7 586.8 26757.9 39573.2 40591.6 40733.0 44899.0 40828.6 41170.4 41260.0 41370.6 41390.6 7668.7 7771.3 7799.8 7812.4 7813.8 7354.4 9631.3 9886.9 9893.3 10230.1 10060.4 10063.5 10138.3 10162.2 10162.2 9852.4 9873.5 9891.4 9900.9 9905.6 9791.0 9826.2 9860.3 9880.3 9903.5 38369.6 38533.2 38573.0 38596.2 38768.6 2659.1 2809.4 2855.7 2991.3 3442.0 28978.7 29117.9 29261.9 29452.0 29708.7 3001.7 3023.9 3030.5 3042.2 3061.3 264974.0 267545.0 269992.0 270010.0 271533.0 31515.2 54366.5 54906.0 54909.5 54927.0 28089.2 29573.1 29581.4 29598.7 29620.7 12458.8 12584.7 12587.9 12589.6 12592.3 9398.4 9684.4 10090.5 10145.4 10155.8 7645.9 7722.9 7827.5 7863.3 7878.8 3013.8 3038.2 3074.4 3078.2 3090.6 827.5 841.5 844.6 848.1 850.2 25964.5 27133.5 27605.4 27694.9 27939.0 867.6 892.4 892.8 932.1 967.8 14277.5 14364.4 14609.8 14687.8 14881.4 393095.0 395354.1 397602.0 398244.0 399993.0 48163.3 48793.3 48823.5 48854.8 49011.8 1061.5 1132.3 1183.5 1193.9 1206.0 27536.4 28769.7 29032.0 29236.7 29539.3 40927.2 41587.6 41590.0 41607.8 41701.6 317337.0 318335.0 318388.0 319135.0 319325.0 24631.9 25687.4 25690.5 26518.6 26710.9 40728.8 41324.0 41445.6 41504.2 41545.2 34464.1 34642.0 34881.0 35288.5 35556.8 35010.5 35338.0 35609.8 35756.0 36054.0 34766.7 35106.1 35266.5 35328.3 36130.0 30481.0 32556.8 32725.8 32792.0 32823.8 24290.5 24761.6 24891.1 25111.2 25245.5 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#2] jquery.html Cycles:180 Average:25394.28 Median:5272.14 stddev:68705.78 (1303.2%) stddev-sans-first:68872.79 03:29:47 INFO - PROCESS | 3395 | Values: 348.6 369.9 374.5 377.0 388.7 12857.4 16242.3 16735.5 17083.3 18232.9 15583.7 16056.8 16098.4 16219.2 16318.9 4677.7 5055.4 5151.8 5395.7 5435.5 3507.6 5161.3 5457.2 5487.5 5487.6 5343.3 5427.1 5442.7 5446.4 5471.2 5265.5 5383.1 5416.5 5425.7 5450.3 5263.2 5269.8 5270.1 5270.4 5273.9 12595.3 17704.9 18912.6 21398.7 21543.8 1730.7 1789.0 1795.1 1806.9 1911.9 9110.9 9215.2 9551.3 9749.5 12844.6 1661.0 1723.0 1731.2 1764.4 1825.2 71687.0 73703.3 75603.6 76303.2 76926.0 9827.7 9985.9 10024.7 10043.6 10163.2 14177.9 14223.9 14238.1 14280.9 14286.4 6784.0 6865.2 6944.0 7012.3 7086.4 6318.1 6361.4 6516.6 6517.1 6522.9 4188.6 4283.9 4306.2 4440.9 4454.3 1712.7 1801.1 1814.7 1816.9 1861.8 765.8 787.9 811.3 853.2 900.1 16746.2 17052.7 17811.3 17814.3 18021.5 804.3 825.1 845.1 879.2 886.6 8863.1 9209.3 9309.3 9683.8 9902.4 404560.0 415204.0 416760.0 416796.0 417200.0 85380.6 87868.0 88059.6 88240.0 88732.0 890.0 908.3 930.4 932.9 933.0 14059.9 14893.5 15316.7 15359.9 15389.3 38009.6 38044.8 38371.8 39480.2 39917.6 55310.4 55406.2 56602.2 56644.4 56780.1 4933.5 6455.7 7614.0 7656.3 7962.4 9897.5 11432.4 11677.4 11724.6 11770.4 9467.1 9594.0 9661.4 9761.3 10004.8 4625.1 7101.9 9311.0 10229.4 10471.3 8822.0 9730.0 9886.2 10047.4 10246.9 7455.9 7536.4 7581.8 7677.2 7772.6 9003.5 9880.7 9943.6 9982.8 10325.1 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#3] mootools.html Cycles:180 Average:5143.54 Median:4709.60 stddev:2951.62 (62.7%) stddev-sans-first:2945.12 03:29:47 INFO - PROCESS | 3395 | Values: 1213.1 1302.8 1345.8 1353.4 1634.8 6618.5 7667.1 7921.4 7926.8 8158.6 7928.1 7953.7 7956.6 7970.3 7994.4 2222.9 2247.7 2252.2 2252.8 2252.9 2183.2 2224.8 2235.8 2242.5 2245.7 2174.3 2217.7 2227.1 2228.3 2230.0 2162.6 2179.8 2181.6 2190.5 2195.4 2151.8 2156.3 2156.9 2157.1 2157.4 7813.8 7908.7 7908.8 7944.4 7975.3 4369.3 4561.1 4563.7 4565.8 4573.0 2741.0 2875.1 2926.6 2940.5 2941.9 900.3 904.0 920.3 926.1 933.4 10734.2 10823.3 10828.0 10836.3 10873.0 3827.6 4023.1 4139.4 4182.6 4185.0 8341.5 8363.2 8386.0 8430.1 8447.9 4424.4 4444.6 4454.6 4460.3 4462.1 3625.9 3954.8 4121.1 4137.7 4139.4 3377.2 3404.1 3490.2 3495.4 3606.7 1011.7 1045.0 1052.1 1057.0 1068.7 780.7 789.1 789.7 804.8 830.4 5135.7 5151.6 5315.4 5338.3 5349.9 389.1 403.6 407.1 409.4 414.8 3545.7 3584.5 3614.0 3649.2 3689.8 9484.1 9965.9 9977.9 9978.6 9984.1 9988.3 9989.3 9998.6 10009.4 10031.9 7410.9 7489.1 7496.8 7498.9 7506.6 5365.9 5502.1 5613.7 5669.7 5772.0 8903.5 9071.6 9316.8 9332.8 9338.4 9001.5 9055.7 9161.5 9184.4 9348.3 7042.9 7126.1 7175.8 7305.9 7411.4 7295.1 7367.8 7382.2 7383.3 7397.3 6579.2 6626.0 6671.0 6697.1 6979.1 6597.1 6619.9 6632.7 6637.3 6768.7 6084.3 6160.3 6161.8 6165.5 6170.3 4526.4 4612.7 4624.4 4695.5 4708.6 4496.2 4518.7 4533.9 4612.3 4710.6 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#4] prototype.html Cycles:180 Average:4069.46 Median:4402.28 stddev:1156.79 (26.3%) stddev-sans-first:1125.00 03:29:47 INFO - PROCESS | 3395 | Values: 304.8 305.4 313.5 315.7 317.8 4778.6 4845.7 4933.4 4968.5 4973.2 4682.5 4828.6 4839.1 4851.5 4856.6 3876.4 3876.6 3890.6 3899.4 3900.7 3624.9 3652.9 3867.3 3884.6 3896.6 3844.3 3857.1 3857.1 3859.3 3871.3 3842.1 3845.7 3846.6 3849.9 3853.7 3399.4 3399.9 3404.7 3417.3 3423.9 4573.4 4666.3 4705.8 4734.8 4745.1 4377.8 4392.5 4400.1 4403.0 4406.4 5052.1 5059.4 5069.4 5093.4 5105.0 3624.7 3717.8 3724.8 3733.1 3737.0 5271.6 5277.9 5308.3 5320.6 5321.6 3817.8 3819.0 3824.8 3826.7 3831.0 3751.8 3874.6 3875.3 3891.6 3894.6 4260.7 4278.7 4282.2 4285.6 4308.7 5027.8 5030.2 5032.4 5033.9 5087.8 1265.4 1302.9 1321.1 1332.8 1334.0 842.3 856.6 860.9 863.4 865.1 4018.2 4045.7 4064.9 4079.1 4159.9 4547.2 4563.5 4573.5 4593.8 4650.0 4018.9 4024.9 4042.9 4057.8 4063.0 2351.0 2423.6 2436.3 2445.0 2459.9 4333.5 4354.8 4382.8 4388.3 4390.2 4694.3 4720.9 4726.3 4766.8 4807.5 4063.9 4375.8 4401.6 4413.7 4426.9 4574.7 4579.3 4583.5 4626.6 4630.3 4512.5 4521.2 4537.6 4594.4 4625.0 4065.5 4373.6 4376.9 4381.7 4389.9 3426.0 3448.5 3459.5 3477.8 3481.4 4641.5 4648.6 4669.8 4699.5 4711.0 4935.0 5032.6 5075.4 5083.4 5091.6 4470.2 4971.8 5063.2 5077.8 5083.2 5035.1 5042.3 5058.5 5062.2 5069.0 5048.4 5178.7 5191.3 5192.2 5196.0 4930.1 4960.6 4991.8 4998.5 5002.9 03:29:47 INFO - PROCESS | 3395 | 03:29:47 INFO - PROCESS | 3395 | [#5] yui.html Cycles:180 Average:16070.97 Median:6060.99 stddev:23375.17 (385.7%) stddev-sans-first:23411.94 03:29:47 INFO - PROCESS | 3395 | Values: 617.5 652.8 672.8 727.4 736.7 11548.3 12154.4 12169.8 12187.8 12188.5 12118.3 12210.3 12212.1 12250.4 12259.7 620.7 747.4 750.2 769.5 773.8 769.1 772.6 775.6 776.3 776.8 801.0 801.5 801.6 802.0 802.7 645.1 663.2 664.5 664.8 803.9 550.7 568.2 568.5 568.8 569.0 12524.9 12525.6 12540.7 12541.9 12567.9 12308.0 12547.2 12697.4 13042.7 13278.5 11003.4 11202.4 11316.2 11486.3 11636.2 3988.5 4028.4 4100.5 4126.3 4141.5 57055.0 57137.4 57162.7 57274.4 57644.1 9691.2 9956.3 10456.5 10468.3 10498.8 18423.6 18554.3 18593.0 18663.6 18679.2 5986.7 6057.2 6064.8 6068.9 6160.5 3469.2 3522.3 3524.9 3542.1 3572.3 2616.6 2718.1 2718.4 2719.6 2720.1 456.6 460.1 461.7 471.7 478.6 461.4 467.2 514.7 529.8 547.8 6488.5 6532.5 6980.4 7143.7 7181.2 441.6 510.3 513.8 521.1 549.5 3128.2 3224.2 3302.2 3371.8 3411.2 54418.7 55050.0 55217.7 57426.0 100891.0 83060.0 83508.6 84192.0 84426.0 87878.6 73159.6 75741.2 77689.2 77850.0 78157.0 6412.8 6551.7 6569.7 6629.7 6682.7 44746.1 45750.8 46667.0 46796.0 47894.5 57940.7 62689.0 65045.7 65324.7 67467.7 8504.7 8551.8 8604.8 8712.8 8756.6 8585.2 8680.3 8839.8 8856.0 8923.2 7921.7 8082.4 8115.0 8176.5 8354.0 8519.3 8550.8 8581.1 8654.5 8665.1 8125.7 8195.0 8218.3 8238.5 8267.6 7084.4 7282.1 7306.1 7309.0 7553.7 7199.5 7205.4 7237.2 7532.3 7559.8 03:29:47 INFO - PROCESS | 3395 | -------- Summary: end -------- 03:29:47 INFO - PROCESS | 3395 | 03:29:48 INFO - TEST-INFO | 3395: exit 0 03:29:48 INFO - TEST-OK | dromaeo_css | took 1126779ms 03:29:48 INFO - TEST-START | kraken 03:29:48 INFO - operating with platform_type : linux_ 03:29:48 INFO - Initialising browser for kraken test... 03:29:48 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLiYXfn/profile http://localhost:45419/getInfo.html) 03:29:53 INFO - PROCESS | 3584 | JavaScript error: , line 0: uncaught exception: undefined 03:29:53 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 03:29:53 INFO - PROCESS | 3584 | colorDepth:24 03:29:53 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 03:29:53 INFO - PROCESS | 3584 | __metrics 03:29:55 INFO - PROCESS | 3584 | 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" 03:29:55 INFO - PROCESS | 3584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:55 INFO - PROCESS | 3584 | console.error: PushService: 03:29:55 INFO - PROCESS | 3584 | stateChangeProcessEnqueue: Error transitioning state 03:29:55 INFO - PROCESS | 3584 | UnknownError 03:29:56 INFO - TEST-INFO | 3584: exit 0 03:29:56 INFO - Browser initialized. 03:29:56 INFO - Running cycle 1/1 for kraken test... 03:29:56 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLiYXfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:08 INFO - PROCESS | 3663 | RSS: Main: 159342592 03:30:08 INFO - PROCESS | 3663 | 03:30:11 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-beat-detection) 03:30:12 INFO - PROCESS | 3663 | RSS: Main: 215216128 03:30:12 INFO - PROCESS | 3663 | 03:30:14 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-dft) 03:30:15 INFO - PROCESS | 3663 | RSS: Main: 188981248 03:30:15 INFO - PROCESS | 3663 | 03:30:18 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-fft) 03:30:19 INFO - PROCESS | 3663 | RSS: Main: 273633280 03:30:19 INFO - PROCESS | 3663 | 03:30:21 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45419/tests/kraken/driver.html?testName=audio-oscillator) 03:30:22 INFO - PROCESS | 3663 | RSS: Main: 182591488 03:30:22 INFO - PROCESS | 3663 | 03:30:24 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:30:24 INFO - PROCESS | 3663 | RSS: Main: 186707968 03:30:24 INFO - PROCESS | 3663 | 03:30:27 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:28 INFO - PROCESS | 3663 | RSS: Main: 223629312 03:30:28 INFO - PROCESS | 3663 | 03:30:32 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45419/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:32 INFO - PROCESS | 3663 | RSS: Main: 217083904 03:30:32 INFO - PROCESS | 3663 | 03:30:35 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45419/tests/kraken/driver.html?testName=json-parse-financial) 03:30:36 INFO - PROCESS | 3663 | RSS: Main: 219897856 03:30:36 INFO - PROCESS | 3663 | 03:30:38 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:38 INFO - PROCESS | 3663 | RSS: Main: 185888768 03:30:38 INFO - PROCESS | 3663 | 03:30:40 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:40 INFO - PROCESS | 3663 | RSS: Main: 190410752 03:30:40 INFO - PROCESS | 3663 | 03:30:43 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:43 INFO - PROCESS | 3663 | RSS: Main: 195715072 03:30:43 INFO - PROCESS | 3663 | 03:30:46 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:47 INFO - PROCESS | 3663 | RSS: Main: 190726144 03:30:47 INFO - PROCESS | 3663 | 03:30:49 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:50 INFO - PROCESS | 3663 | RSS: Main: 194772992 03:30:50 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:45419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45419/tests/kraken/driver.html?testName=ai-astar) 03:30:52 INFO - PROCESS | 3663 | RSS: Main: 245219328 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | __start_tp_report 03:30:52 INFO - PROCESS | 3663 | _x_x_mozilla_page_load 03:30:52 INFO - PROCESS | 3663 | _x_x_mozilla_page_load_details 03:30:52 INFO - PROCESS | 3663 | |i|pagename|runs| 03:30:52 INFO - PROCESS | 3663 | |0;ai-astar;103;113;113;114;112;114;113;112;112;113 03:30:52 INFO - PROCESS | 3663 | |1;audio-beat-detection;149;128;123;189;123;125;148;122;158;121 03:30:52 INFO - PROCESS | 3663 | |2;audio-dft;162;161;161;160;161;161;162;162;160;162 03:30:52 INFO - PROCESS | 3663 | |3;audio-fft;75;76;75;118;76;76;77;84;100;74 03:30:52 INFO - PROCESS | 3663 | |4;audio-oscillator;85;85;111;85;86;85;113;85;85;122 03:30:52 INFO - PROCESS | 3663 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 03:30:52 INFO - PROCESS | 3663 | |6;imaging-darkroom;146;146;146;146;146;147;145;146;147;146 03:30:52 INFO - PROCESS | 3663 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 03:30:52 INFO - PROCESS | 3663 | |8;json-parse-financial;63;61;63;62;62;63;65;63;62;62 03:30:52 INFO - PROCESS | 3663 | |9;json-stringify-tinderbox;64;65;65;67;66;64;65;65;65;65 03:30:52 INFO - PROCESS | 3663 | |10;stanford-crypto-aes;82;80;88;80;79;90;79;79;77;80 03:30:52 INFO - PROCESS | 3663 | |11;stanford-crypto-ccm;130;131;128;130;127;129;141;127;180;149 03:30:52 INFO - PROCESS | 3663 | |12;stanford-crypto-pbkdf2;168;164;167;167;171;164;168;171;169;162 03:30:52 INFO - PROCESS | 3663 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;67;71;70;66;70 03:30:52 INFO - PROCESS | 3663 | __end_tp_report 03:30:52 INFO - PROCESS | 3663 | __start_cc_report 03:30:52 INFO - PROCESS | 3663 | _x_x_mozilla_cycle_collect,1910 03:30:52 INFO - PROCESS | 3663 | __end_cc_report 03:30:52 INFO - PROCESS | 3663 | __startTimestamp1469615452586__endTimestamp 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | ------- Summary: start ------- 03:30:52 INFO - PROCESS | 3663 | Number of tests: 14 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.21 (2.8%) stddev-sans-first:0.78 03:30:52 INFO - PROCESS | 3663 | Values: 103.0 113.0 113.0 114.0 112.0 114.0 113.0 112.0 112.0 113.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:138.00 stddev:22.32 (16.2%) stddev-sans-first:23.35 03:30:52 INFO - PROCESS | 3663 | Values: 149.0 128.0 123.0 189.0 123.0 125.0 148.0 122.0 158.0 121.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:30:52 INFO - PROCESS | 3663 | Values: 162.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 160.0 162.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:14.56 (19.2%) stddev-sans-first:15.14 03:30:52 INFO - PROCESS | 3663 | Values: 75.0 76.0 75.0 118.0 76.0 76.0 77.0 84.0 100.0 74.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:85.00 stddev:14.85 (17.5%) stddev-sans-first:15.37 03:30:52 INFO - PROCESS | 3663 | Values: 85.0 85.0 111.0 85.0 86.0 85.0 113.0 85.0 85.0 122.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:30:52 INFO - PROCESS | 3663 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:30:52 INFO - PROCESS | 3663 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 147.0 146.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:30:52 INFO - PROCESS | 3663 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 03:30:52 INFO - PROCESS | 3663 | Values: 63.0 61.0 63.0 62.0 62.0 63.0 65.0 63.0 62.0 62.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 03:30:52 INFO - PROCESS | 3663 | Values: 64.0 65.0 65.0 67.0 66.0 64.0 65.0 65.0 65.0 65.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:4.22 (5.3%) stddev-sans-first:4.47 03:30:52 INFO - PROCESS | 3663 | Values: 82.0 80.0 88.0 80.0 79.0 90.0 79.0 79.0 77.0 80.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:130.50 stddev:16.63 (12.7%) stddev-sans-first:17.43 03:30:52 INFO - PROCESS | 3663 | Values: 130.0 131.0 128.0 130.0 127.0 129.0 141.0 127.0 180.0 149.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:3.00 (1.8%) stddev-sans-first:3.16 03:30:52 INFO - PROCESS | 3663 | Values: 168.0 164.0 167.0 167.0 171.0 164.0 168.0 171.0 169.0 162.0 03:30:52 INFO - PROCESS | 3663 | 03:30:52 INFO - PROCESS | 3663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:1.96 (2.9%) stddev-sans-first:2.06 03:30:52 INFO - PROCESS | 3663 | Values: 67.0 66.0 67.0 66.0 66.0 67.0 71.0 70.0 66.0 70.0 03:30:52 INFO - PROCESS | 3663 | -------- Summary: end -------- 03:30:52 INFO - PROCESS | 3663 | 03:30:53 INFO - TEST-INFO | 3663: exit 0 03:30:53 INFO - TEST-OK | kraken | took 65023ms 03:30:53 INFO - SUITE-END | took 1191s 03:30:54 INFO - Completed test suite (00:19:52) 03:30:54 INFO - javascript benchmark 03:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.9472810543803, 2658.6809582850055, 2667.0, 2671.9198424047286, 2675.9063432779844, 4620.0, 4675.392199014132, 4682.180618391781, 4774.809007639695, 4808.230683090702, 4672.415948006499, 4700.576948074672, 4770.7853146608395, 4812.663113582051, 4819.0843739689435, 4266.296061149907, 4278.700490965633, 4339.826406943718, 4390.143921935224, 4480.23835947888, 4399.538048504893, 4436.068425630621, 4444.555544445562, 4451.688381813275, 4453.821847126111, 4304.053108316165, 4342.652587792969, 4348.630366418858, 4403.581659742319, 4408.316710909814, 4306.504751953503, 4357.3899654048455, 4382.517923028464, 4413.051193993307, 4421.049474363027, 4311.784410779448, 4318.805653745558, 4327.545607711208, 4371.213181627306, 4400.581944715247, 4730.526947305242, 4751.121042607128, 4787.40157480315, 4797.832075877328, 4798.0643774464, 4840.540148685905, 5040.319556859814, 5085.974570127163, 5094.821681241176, 5107.923381149286, 5115.411727651331, 5164.302819119446, 5167.147420675584, 5174.922376164361, 5179.430262671103, 4754.5007774183905, 4770.308305295713, 4794.113089078532, 4807.206810876236, 4807.711537307773, 5028.522290382481, 5044.243363495431, 5128.589712822965, 5146.6911985281, 5184.040952423814, 4985.800567977313, 4990.226514890198, 5030.170021946338, 5036.345275114211, 5036.521530454601, 5077.0, 5086.54221120101, 5117.513836185556, 5129.410117836496, 5136.409312929061, 4915.336429581961, 4984.601231901439, 5004.049230646166, 5031.0441016206805, 5033.723145227048, 5007.624428167902, 5019.196928491424, 5021.698698078127, 5022.89954200914, 5054.393472783289, 4243.851465198765, 4245.57544245573, 4256.425382573375, 4280.165367753259, 4285.121550082225, 3686.4286035664513, 3713.9814300928865, 3720.516332876709, 3721.5162028936606, 3744.3634582121103, 4397.648188144941, 4413.249747542925, 4440.156370289635, 4461.866144015685, 4463.2635615123145, 5064.366954130734, 5068.949310506921, 5072.036313100499, 5079.6952182869145, 5084.974575127175, 4307.547707490731, 4386.4736231652405, 4389.780510974439, 4398.472183337956, 4436.711613745097, 4561.201789686792, 4571.657125715585, 4604.470485894098, 4623.398958135488, 4623.606993405599, 4793.209120495079, 4794.760261986957, 4802.471728109975, 4804.495527969652, 4848.175810112219, 4957.727324997016, 5012.573931215888, 5061.670991385696, 5071.822486212965, 5101.056304583664, 4813.9037219256115, 4829.348038014823, 4829.95170048295, 4861.611071114373, 4878.975605122094, 5045.167547354646, 5049.419316778471, 5051.166557517969, 5053.115704751727, 5095.974520127375, 4937.679050861682, 5061.822836200715, 5071.822486212965, 5097.08252514551, 5142.794288228429, 5013.2981382607195, 5017.0, 5021.949780502148, 5045.192769156917, 5052.292679024866, 4988.251762235694, 4992.226204938241, 5000.699958002531, 5004.099262132705, 5048.949510504995, 4738.857834264978, 4765.880852978703, 4795.424549053996, 4939.851804445872, 5002.374703162105, 4943.085529177114, 4945.035718035093, 4955.0, 4963.900721985612, 4984.02811451778, 4867.926981095357, 4873.561379475864, 4874.439439464365, 4883.218685010382, 4927.950720492892], "value": 4666.056746774383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8081092833901, 574.3968832725637, 586.2173997713054, 586.6802592587039, 586.8151532267339, 26757.866210668944, 39573.208535829304, 40591.59408405915, 40733.0, 44899.0, 40828.59171408285, 41170.38244426328, 41260.0, 41370.58629413705, 41390.58609413912, 7668.654910529026, 7771.290316130442, 7799.844003119934, 7812.375009999215, 7813.765587032398, 7354.448416368767, 9631.27765417593, 9886.851697224547, 9893.30746847721, 10230.130438912664, 10060.446675432848, 10063.496825158749, 10138.341007834504, 10162.18702503798, 10162.18702503798, 9852.359596626233, 9873.506324683736, 9891.35706179096, 9900.90099099007, 9905.554250058765, 9790.9510452448, 9826.16477599405, 9860.30977831552, 9880.258980576486, 9903.504824758733, 38369.61630383688, 38533.22933541313, 38573.0, 38596.228075438616, 38768.61231387678, 2659.095907391477, 2809.4100238949845, 2855.6858745537975, 2991.311998240417, 3441.9827900860337, 28978.71021289781, 29117.85441072781, 29261.853690731623, 29452.0, 29708.70291297081, 3001.6998300170026, 3023.9244018899703, 3030.5151175811984, 3042.2242328206166, 3061.280599059219, 264974.0, 267544.9999999981, 269992.0, 270010.0, 271533.0, 31515.21211969719, 54366.45633543693, 54906.0, 54909.450905490434, 54927.0, 28089.157325280274, 29573.112806615834, 29581.408371832444, 29598.704012960025, 29620.703792962224, 12458.75082498363, 12584.685382865502, 12587.937060314824, 12589.622311330675, 12592.307423091817, 9398.436093834393, 9684.370515916584, 10090.49547522621, 10145.442000690033, 10155.847662285072, 7645.923540764632, 7722.884156737653, 7827.530348179127, 7863.292303692695, 7878.763637090897, 3013.758899288052, 3038.194878357193, 3074.400491904102, 3078.2150551609197, 3090.5518699788404, 827.4580150001758, 841.4993079117914, 844.5903736687701, 848.1433751910615, 850.1583432402001, 25964.480710386066, 27133.457330853667, 27605.447891042066, 27694.861525692242, 27939.0, 867.6399294292924, 892.3887137310962, 892.7991201979503, 932.1383353105899, 967.7919247361851, 14277.500287489887, 14364.35360408784, 14609.831213502894, 14687.77968330476, 14881.404743810343, 393095.0, 395354.1161470986, 397602.0, 398244.0, 399993.0, 48163.27755083676, 48793.268100978516, 48823.511764882605, 48854.75572622114, 49011.75494122507, 1061.4851796878509, 1132.3432409202642, 1183.4556104191995, 1193.9223950443193, 1205.9939700301443, 27536.44927101487, 28769.712302876702, 29032.0, 29236.678107611675, 29539.261518462212, 40927.18145637011, 41587.58412415837, 41590.0, 41607.79196104, 41701.582984170986, 317337.0, 318335.0, 318388.0, 319135.0, 319325.0, 24631.87684061568, 25687.357816054748, 25690.486190275715, 26518.60222096709, 26710.866445668424, 40728.79635601803, 41324.0, 41445.585544144174, 41504.169916602106, 41545.169096618505, 34464.138396540286, 34642.0, 34881.0, 35288.47067294044, 35556.82221588876, 35010.474842877884, 35338.0, 35609.82195089111, 35756.0, 36054.0, 34766.65233347634, 35106.12234694153, 35266.471002934464, 35328.29343413169, 36130.0, 30481.0, 32556.837215813768, 32725.836370817993, 32792.0, 32823.83588082044, 24290.51418971646, 24761.62857557174, 24891.128810491547, 25111.24666260015, 25245.495090097727], "value": 16559.98175802579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.56951664694117, 369.86499927526444, 374.5355758859015, 376.95476542814856, 388.6696308138083, 12857.421416036277, 16242.269097890594, 16735.497935061954, 17083.316667333293, 18232.908835455837, 15583.688326233498, 16056.83943160568, 16098.356065757385, 16219.189040547984, 16318.918405407985, 4677.695949763263, 5055.3933527976515, 5151.81968631098, 5395.73021348933, 5435.456454354572, 3507.5615548056494, 5161.27742116104, 5457.208704737831, 5487.506124448799, 5487.6158668892995, 5343.251944727741, 5427.104527752916, 5442.727863606824, 5446.373667028283, 5471.151971444432, 5265.4997775211295, 5383.057964856134, 5416.458354164592, 5425.7287135643255, 5450.264214331054, 5263.210518422229, 5269.762860671241, 5270.051390749663, 5270.367555893279, 5273.920891186635, 12595.3072581008, 17704.937703737687, 18912.62174756511, 21398.679019814714, 21543.784562154335, 1730.6625208084429, 1788.9821101789075, 1795.1024487756122, 1806.9277228910828, 1911.9426417207505, 9110.86333704995, 9215.216706579882, 9551.283653725928, 9749.463779492125, 12844.550440734529, 1661.0448991829746, 1722.9741553876702, 1731.2382551677222, 1764.408923010793, 1825.2334019711752, 71687.0, 73703.26296737017, 75603.62198189029, 76303.23696763073, 76926.0, 9827.705168844946, 9985.851627062835, 10024.749381265527, 10043.598256069676, 10163.18694504438, 14177.858221417653, 14223.92888035574, 14238.074525156038, 14280.928595356956, 14286.42854285817, 6784.0, 6865.210500792373, 6943.9652801735665, 7012.333828286304, 7086.362227399559, 6318.147050148263, 6361.363863613602, 6516.57642253252, 6517.087607734921, 6522.869542609121, 4188.602082802129, 4283.850065247701, 4306.20335237982, 4440.933385999213, 4454.331850222493, 1712.6831536165848, 1801.1174524483172, 1814.7005744052346, 1816.8546516278666, 1861.8231268029515, 765.8430021845509, 787.9054513458422, 811.3184924663311, 853.1681610429905, 900.104396125859, 16746.162691865356, 17052.744208836877, 17811.287548497916, 17814.287428502976, 18021.549461263574, 804.3002587748696, 825.0800357601352, 845.1168528887328, 879.2174964281794, 886.5567216391804, 8863.113688631085, 9209.257232525255, 9309.255259579217, 9683.757906052264, 9902.356346837576, 404560.0, 415204.0, 416760.0, 416796.0, 417200.0, 85380.57309713411, 87868.0, 88059.55970220236, 88240.0, 88732.0, 889.9510526920952, 908.327837400319, 930.432436213909, 932.9253659707207, 933.0389698610442, 14059.859401405854, 14893.47872824446, 15316.693666126837, 15359.923200383926, 15389.307481163598, 38009.61990380061, 38044.80977595094, 38371.80814095912, 39480.2103957925, 39917.600823991386, 55310.44689553214, 55406.16890746562, 56602.15096773634, 56644.433555665564, 56780.148297776395, 4933.531314525115, 6455.677216139268, 7613.961930190314, 7656.349210317186, 7962.402819788424, 9897.50512474359, 11432.428378580871, 11677.357745324089, 11724.58963936258, 11770.3526306054, 9467.100625440573, 9594.0, 9661.420314781135, 9761.316707830383, 10004.84992725095, 4625.07498500308, 7101.899205623136, 9311.0, 10229.43738094412, 10471.3193642413, 8822.0, 9729.951350243487, 9886.209103271578, 10047.397156170653, 10246.948765256126, 7455.888161677471, 7536.359409450039, 7581.772546823604, 7677.193894640982, 7772.611369431619, 9003.54982250898, 9880.654177103766, 9943.602255909971, 9982.800343992934, 10325.070743633109], "value": 8091.089508306294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.0780606738876, 1302.8241187439694, 1345.8115863779071, 1353.3706826325756, 1634.8283430239824, 6618.470522358211, 7667.118281397641, 7921.366290696745, 7926.762197134095, 8158.632861521231, 7928.127905930343, 7953.681852725898, 7956.562389068599, 7970.286388426487, 7994.400419968511, 2222.8555143915632, 2247.6965609642734, 2252.200468833565, 2252.7747225277503, 2252.8648281103106, 2183.224955140926, 2224.7997680208778, 2235.776422357759, 2242.495438526335, 2245.7305123385136, 2174.315090746418, 2217.7227846519186, 2227.120287486442, 2228.2535350657467, 2230.02993697742, 2162.610730068587, 2179.8256139508803, 2181.5964046651343, 2190.496185877257, 2195.4401627584944, 2151.752548456932, 2156.2884248198056, 2156.870587764739, 2157.0508976050646, 2157.4174972757423, 7813.765587032398, 7908.683652653887, 7908.762737117896, 7944.364450843918, 7975.282224599814, 4369.322754972953, 4561.1105834362315, 4563.699345686497, 4565.771711414416, 4573.0396616710195, 2740.986295068532, 2875.1374587623627, 2926.590277361171, 2940.5442156465783, 2941.911742647724, 900.3292547052422, 903.9502827344494, 920.3327587499076, 926.1386910173536, 933.4352716606492, 10734.194935379799, 10823.296485728402, 10828.0, 10836.349819010884, 10873.0, 3827.6363745444137, 4023.114914718757, 4139.4204811326435, 4182.64447521964, 4185.016521117535, 8341.5412152331, 8363.163683631588, 8386.0, 8430.072692003874, 8447.873281900776, 4424.446944131983, 4444.622207112432, 4454.643628509712, 4460.28635418338, 4462.062966776948, 3625.8912232633065, 3954.7824869632445, 4121.113960498507, 4137.689673274516, 4139.4204811326435, 3377.2401209728105, 3404.14896275931, 3490.1798077451776, 3495.3708332500396, 3606.747527673038, 1011.726833754882, 1045.0490054050777, 1052.1162223732101, 1057.0, 1068.6687126990657, 780.6526095887276, 789.06889869954, 789.6920201121567, 804.7666176808777, 830.4270053662954, 5135.743212839343, 5151.5621172200035, 5315.3621565412395, 5338.3060202173465, 5349.919751203735, 389.1302937933716, 403.5984195725213, 407.1368698359497, 409.43089106142486, 414.834066373447, 3545.6808887200277, 3584.4981702561663, 3613.9819300903855, 3649.1789347397153, 3689.815509224528, 9484.146426821619, 9965.900340996643, 9977.850332245021, 9978.550965206583, 9984.051515106054, 9988.25088118394, 9989.250806189564, 9998.550065247082, 10009.449480278508, 10031.899681003242, 7410.925890741131, 7489.101307843093, 7496.7750967471065, 7498.887516687254, 7506.587137707478, 5365.946340536545, 5502.064649009758, 5613.691246981455, 5669.659820410624, 5772.047612144117, 8903.465792052497, 9071.637134514545, 9316.813663726824, 9332.766680833034, 9338.439693618404, 9001.459912405277, 9055.68305109318, 9161.541922903962, 9184.357095003286, 9348.345615806827, 7042.894356584553, 7126.073610430611, 7175.820604484929, 7305.853882922418, 7411.4070874331, 7295.088113985752, 7367.815804604714, 7382.151052629017, 7383.261673832574, 7397.26027397256, 6579.2104947406615, 6625.966870165618, 6670.966645166744, 6697.0958920547055, 6979.057827193467, 6597.0764093026055, 6619.933800661932, 6632.701528431328, 6637.2699003108655, 6768.661566921733, 6084.330723620486, 6160.260768707604, 6161.784337548164, 6165.475934545434, 6170.321264660974, 4526.388937493396, 4612.654050946126, 4624.352590637381, 4695.460022097366, 4708.623310135249, 4496.190685676479, 4518.683692141519, 4533.909321813611, 4612.30815377696, 4710.576048155683], "value": 4036.2138004238277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.775989647609, 305.36179385085165, 313.451459945096, 315.7379375118652, 317.8251961421219, 4778.569928706415, 4845.733484658343, 4933.3586633737605, 4968.478309777475, 4973.151177601841, 4682.461516925555, 4828.613710903128, 4839.05638400512, 4851.466338702739, 4856.611471082314, 3876.3604005339084, 3876.592957739439, 3890.5525864525657, 3899.4345819856103, 3900.7074469414765, 3624.9456258156147, 3652.8904132876055, 3867.3038853006447, 3884.6309600587897, 3896.590857959916, 3844.2888065707934, 3857.0935830079907, 3857.0935830080048, 3859.3439115350316, 3871.264459752652, 3842.098161410092, 3845.673242731253, 3846.6345697158727, 3849.8652547160996, 3853.6531712146043, 3399.4051041067714, 3399.8980030599123, 3404.6595340465756, 3417.2652879631, 3423.9144021399416, 4573.428321459817, 4666.300054991744, 4705.811767529295, 4734.83428080019, 4745.098431298043, 4377.846775362879, 4392.472903251598, 4400.11997600478, 4402.955970440286, 4406.405135306724, 5052.1411360068505, 5059.355709394462, 5069.366329208849, 5093.446498817859, 5105.03004429161, 3624.746267761258, 3717.75834570752, 3724.7951362675044, 3733.0667333166707, 3737.0283726231105, 5271.551918086967, 5277.920831187497, 5308.309919710451, 5320.627556071038, 5321.627486076015, 3817.84728610858, 3818.961810381916, 3824.78963656996, 3826.693864490834, 3830.9808450958126, 3751.8311675974646, 3874.6319099685484, 3875.2636998970106, 3891.630295121959, 3894.5521265054313, 4260.659147268211, 4278.700490965664, 4282.164977829293, 4285.571442855752, 4308.6983911126545, 5027.79888804451, 5030.170021946338, 5032.421271553745, 5033.949660503348, 5087.753500392353, 1265.4432049898016, 1302.856685764565, 1321.1346567997978, 1332.840059192903, 1333.9733205336033, 842.3135144857044, 856.5802756649197, 860.875173099897, 863.3826813828143, 865.1089377940731, 4018.236535058388, 4045.6561192298395, 4064.878053658395, 4079.0822065035723, 4159.875203743893, 4547.1815073287125, 4563.54364563541, 4573.536468330169, 4593.839215627437, 4650.00024994621, 4018.8794336169963, 4024.91950161001, 4042.8989275268355, 4057.776822274744, 4062.9593704063172, 2350.9647355289685, 2423.6243382275775, 2436.317831007321, 2444.985331087614, 2459.9016039358585, 4333.458317710286, 4354.782260886943, 4382.846600368972, 4388.2759344707765, 4390.209762242827, 4694.319323698045, 4720.929186062212, 4726.26742854858, 4766.809327626926, 4807.495213002654, 4063.938504625565, 4375.812093953024, 4401.603855653007, 4413.713108647928, 4426.915405725682, 4574.7255164688895, 4579.335996280454, 4583.54164583539, 4626.606738427271, 4630.259158534618, 4512.548745125461, 4521.186186486464, 4537.636989040935, 4594.356790049463, 4624.982503849148, 4065.484581935113, 4373.562643735601, 4376.862015875831, 4381.693281470267, 4389.924468505236, 3426.0471531226963, 3448.4827275908815, 3459.4605400597497, 3477.8434970425888, 3481.3559491494157, 4641.489436161952, 4648.558386953234, 4669.766511674471, 4699.53004699541, 4710.952890471051, 4934.9753251233515, 5032.572231360229, 5075.365579302587, 5083.364579427572, 5091.643584949018, 4470.173017991682, 4971.825986090469, 5063.240513922941, 5077.77150028257, 5083.237514372874, 5035.086667066637, 5042.268871013609, 5058.519440653132, 5062.190049592047, 5068.974655126701, 5048.396658314125, 5178.741062946913, 5191.299174611379, 5192.221166825007, 5195.9740201298755, 4930.137225985366, 4960.627952903475, 4991.750412479434, 4998.525140111684, 5002.949970500394], "value": 3709.7826798737974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.5245061302796, 652.8400541867246, 672.7914346552573, 727.3998950865534, 736.6979538389262, 11548.3071015739, 12154.39228038599, 12169.817452738216, 12187.756244875098, 12188.51245950162, 12118.272903625788, 12210.32843193624, 12212.084093692964, 12250.387480625956, 12259.693507662312, 620.7237779188263, 747.428217413679, 750.2160242546538, 769.5498133591856, 773.8490994256123, 769.1347234361343, 772.6059709548115, 775.592813772771, 776.3401109057285, 776.763087258386, 801.0147518552184, 801.4550105927966, 801.6432687454085, 801.9879701804477, 802.7350974178536, 645.1290757477415, 663.237277131298, 664.4551467796409, 664.7772996046331, 803.907550631679, 550.6723499517781, 568.2442351672307, 568.4798409455343, 568.8037627018672, 569.0411656359048, 12524.874751252553, 12525.624231273076, 12540.686482838002, 12541.933935615483, 12567.937160314232, 12308.0, 12547.184433011826, 12697.365131743376, 13042.673933151653, 13278.477089352991, 11003.449827508673, 11202.43987800615, 11316.151288653302, 11486.253393529478, 11636.243644163102, 3988.501437320335, 4028.375601781699, 4100.466939297902, 4126.3397856343145, 4141.544430112715, 57055.0, 57137.42862571404, 57162.7141864288, 57274.42725572733, 57644.135337969965, 9691.176250018827, 9956.303058785816, 10456.52945617449, 10468.267221294589, 10498.790024199474, 18423.631527369376, 18554.257829686932, 18593.0, 18663.626727465376, 18679.159437825332, 5986.700664966735, 6057.151998720183, 6064.818055458343, 6068.8786224276155, 6160.476359509492, 3469.2020835208045, 3522.3397548856456, 3524.8766293179615, 3542.0790594445116, 3572.28554289138, 2616.6467526884007, 2718.1030260014545, 2718.374773801997, 2719.619253304539, 2720.143154906198, 456.61187990208055, 460.10279954089657, 461.7321953267164, 471.73818530715783, 478.58124141376294, 461.4186125481917, 467.18009892638884, 514.6834696661526, 529.8172130614931, 547.8137433272707, 6488.513361497907, 6532.510061745388, 6980.406665433394, 7143.678534465961, 7181.174164970991, 441.58711604649113, 510.2856001597793, 513.7816428018077, 521.072490966081, 549.5136803928552, 3128.1553980425156, 3224.2261857154112, 3302.1909632140278, 3371.8482668279985, 3411.1650824365015, 54418.72790636022, 55050.0, 55217.72391138099, 57426.0, 100891.0, 83060.0, 83508.58245708732, 84192.0, 84426.0, 87878.56060719784, 73159.63420182865, 75741.24258757452, 77689.22310776933, 77850.0, 78157.0, 6412.839679008062, 6551.737930482727, 6569.704363303567, 6629.6685165740555, 6682.699278532575, 44746.12870010307, 45750.77124614356, 46667.0, 46796.0, 47894.5210547904, 57940.71029644825, 62689.0, 65045.67477162584, 65324.67337663281, 67467.66266168638, 8504.744857654281, 8551.828963420821, 8604.78488037804, 8712.78218044554, 8756.649734010569, 8585.18440748128, 8680.305575554066, 8839.779005524657, 8855.955720221615, 8923.241524470493, 7921.722739704082, 8082.434229603871, 8114.959425202836, 8176.46852954556, 8354.039285482248, 8519.318454523747, 8550.786230344042, 8581.098984606526, 8654.524001179996, 8665.133486651284, 8125.67497300125, 8194.959025204837, 8218.301444377055, 8238.50568965864, 8267.62795674184, 7084.397826184832, 7282.089738782653, 7306.123265208209, 7308.96345518269, 7553.697852085855, 7199.532030418006, 7205.351518363373, 7237.240089790496, 7532.322091011835, 7559.848803024019], "value": 5853.438841867418, "unit": "score"}], "name": "dromaeo_css", "value": 6163.110237834898, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 114.0, 112.0, 114.0, 113.0, 112.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 123.0, 189.0, 123.0, 125.0, 148.0, 122.0, 158.0, 121.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 118.0, 76.0, 76.0, 77.0, 84.0, 100.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 111.0, 85.0, 86.0, 85.0, 113.0, 85.0, 85.0, 122.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 62.0, 63.0, 65.0, 63.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 67.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 88.0, 80.0, 79.0, 90.0, 79.0, 79.0, 77.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 128.0, 130.0, 127.0, 129.0, 141.0, 127.0, 180.0, 149.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 167.0, 167.0, 171.0, 164.0, 168.0, 171.0, 169.0, 162.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 71.0, 70.0, 66.0, 70.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1527.8999999999999, "alertThreshold": 2.0}]} 03:30:54 INFO - Return code: 0 03:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:54 INFO - # TBPL SUCCESS # 03:30:54 INFO - Running post-action listener: _resource_record_post_action 03:30:54 INFO - [mozharness: 2016-07-27 10:30:54.361506Z] Finished run-tests step (success) 03:30:54 INFO - Running post-run listener: _resource_record_post_run 03:30:54 INFO - Total resource usage - Wall time: 1211s; CPU: 13.0%; Read bytes: 7815168; Write bytes: 418091008; Read time: 3212; Write time: 1345116 03:30:54 INFO - TinderboxPrint: CPU usage
13.1% 03:30:54 INFO - TinderboxPrint: I/O read bytes / time
7,815,168 / 3,212 03:30:54 INFO - TinderboxPrint: I/O write bytes / time
418,091,008 / 1,345,116 03:30:54 INFO - TinderboxPrint: CPU idle
8,394.6 (86.8%) 03:30:54 INFO - TinderboxPrint: CPU user
1,208.8 (12.5%) 03:30:54 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 31776768; Read time: 32; Write time: 14952 03:30:54 INFO - run-tests - Wall time: 1195s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 358309888; Read time: 3180; Write time: 1253296 03:30:54 INFO - Running post-run listener: _upload_blobber_files 03:30:54 INFO - Blob upload gear active. 03:30:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:54 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 03:30:54 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:30:54 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:56 INFO - (blobuploader) - INFO - Done attempting. 03:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:59 INFO - (blobuploader) - INFO - Done attempting. 03:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:00 INFO - (blobuploader) - INFO - Done attempting. 03:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:00 INFO - Return code: 0 03:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b51f31f5436230b5c40cacd1ef29f3833eef3a86642dd65a9ade6708f0eb5e689522f0ad8b986b4192e114786880b7eea7617aa12cecf26d1fbb223fbd1c3b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba4334d44d1bab18c86948382d4131db1e24b52eb9bd6b294b31c84dc9a76e53499ad2dde3401f8e923dbe87ee661dd2565f715e08040ac81bb4000a2081957b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bccef093488a0e8d86adc81bdee2bb9241ad3039d5914919e78a4e3d901a39eccda21d3a2bac3d6b1a7b4664c20b475e978572f6d0f49a3ebe984ee2671d20a5"} 03:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:00 INFO - Contents: 03:31:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b51f31f5436230b5c40cacd1ef29f3833eef3a86642dd65a9ade6708f0eb5e689522f0ad8b986b4192e114786880b7eea7617aa12cecf26d1fbb223fbd1c3b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba4334d44d1bab18c86948382d4131db1e24b52eb9bd6b294b31c84dc9a76e53499ad2dde3401f8e923dbe87ee661dd2565f715e08040ac81bb4000a2081957b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bccef093488a0e8d86adc81bdee2bb9241ad3039d5914919e78a4e3d901a39eccda21d3a2bac3d6b1a7b4664c20b475e978572f6d0f49a3ebe984ee2671d20a5"} 03:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:00 INFO - Copying logs to upload dir... 03:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.332102 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-27 03:31:00.556903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:31:00.560511) ========= 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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 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-Non-PGO/sha512/b51f31f5436230b5c40cacd1ef29f3833eef3a86642dd65a9ade6708f0eb5e689522f0ad8b986b4192e114786880b7eea7617aa12cecf26d1fbb223fbd1c3b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba4334d44d1bab18c86948382d4131db1e24b52eb9bd6b294b31c84dc9a76e53499ad2dde3401f8e923dbe87ee661dd2565f715e08040ac81bb4000a2081957b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bccef093488a0e8d86adc81bdee2bb9241ad3039d5914919e78a4e3d901a39eccda21d3a2bac3d6b1a7b4664c20b475e978572f6d0f49a3ebe984ee2671d20a5"} build_url:https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011029 build_url: 'https://queue.taskcluster.net/v1/task/AtkJ_rQaSbeNMHkKGBaImg/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-Non-PGO/sha512/b51f31f5436230b5c40cacd1ef29f3833eef3a86642dd65a9ade6708f0eb5e689522f0ad8b986b4192e114786880b7eea7617aa12cecf26d1fbb223fbd1c3b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba4334d44d1bab18c86948382d4131db1e24b52eb9bd6b294b31c84dc9a76e53499ad2dde3401f8e923dbe87ee661dd2565f715e08040ac81bb4000a2081957b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bccef093488a0e8d86adc81bdee2bb9241ad3039d5914919e78a4e3d901a39eccda21d3a2bac3d6b1a7b4664c20b475e978572f6d0f49a3ebe984ee2671d20a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:31:00.585716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:31:00.586040) ========= 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=8783db0840cc980e80bb0bd400000236-1469613564.132635-885639852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:31:00.668863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:31:00.669188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:31:00.669490) ========= ========= Total master_lag: 0.19 =========