builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1469227797.22 results: success (0) buildid: 20160722153026 builduid: 5e8db03a220244e491e2ea801fa6699f revision: 933fcf81f9c8661398b077014802441440a84955 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.218030) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.218444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.218722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.233902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.234172) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 15:49:57-- 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% 70.5M=0s 2016-07-22 15:49:57 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.353056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.353423) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017210 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.404124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:57.404543) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 933fcf81f9c8661398b077014802441440a84955 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 933fcf81f9c8661398b077014802441440a84955 --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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 15:49:57,618 truncating revision to first 12 chars 2016-07-22 15:49:57,618 Setting DEBUG logging. 2016-07-22 15:49:57,618 attempt 1/10 2016-07-22 15:49:57,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/933fcf81f9c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 15:49:57,928 unpacking tar archive at: autoland-933fcf81f9c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637646 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:58.055447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:58.055817) ========= script_repo_revision: 933fcf81f9c8661398b077014802441440a84955 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:58.056240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:58.056576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 15:49:58.069214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-22 15:49:58.069507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:49:58 INFO - MultiFileLogger online at 20160722 15:49:58 in /builds/slave/test 15:49:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:49:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:58 INFO - {'append_to_log': False, 15:49:58 INFO - 'base_work_dir': '/builds/slave/test', 15:49:58 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:49:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:58 INFO - 'branch': 'Autoland-Non-PGO', 15:49:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:58 INFO - 'config_files': ('talos/linux_config.py',), 15:49:58 INFO - 'default_actions': ('clobber', 15:49:58 INFO - 'read-buildbot-config', 15:49:58 INFO - 'download-and-extract', 15:49:58 INFO - 'populate-webroot', 15:49:58 INFO - 'create-virtualenv', 15:49:58 INFO - 'install', 15:49:58 INFO - 'run-tests'), 15:49:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:58 INFO - 'download_minidump_stackwalk': True, 15:49:58 INFO - 'download_symbols': 'ondemand', 15:49:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:58 INFO - 'installer_path': 'installer.exe', 15:49:58 INFO - 'log_level': 'info', 15:49:58 INFO - 'log_name': 'talos', 15:49:58 INFO - 'log_to_console': True, 15:49:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:49:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:49:58 INFO - 'opt_config_files': (), 15:49:58 INFO - 'pip_index': False, 15:49:58 INFO - 'sps_profile': False, 15:49:58 INFO - 'sps_profile_interval': 0, 15:49:58 INFO - 'suite': 'dromaeojs', 15:49:58 INFO - 'system_bits': '32', 15:49:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:58 INFO - 'title': 'talos-linux64-ix-015', 15:49:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:58 INFO - 'use_talos_json': True, 15:49:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:58 INFO - 'work_dir': 'build'} 15:49:58 INFO - [mozharness: 2016-07-22 22:49:58.377765Z] Running clobber step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: clobber 15:49:58 INFO - rmtree: /builds/slave/test/build 15:49:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:58 INFO - Running post-action listener: _resource_record_post_action 15:49:58 INFO - [mozharness: 2016-07-22 22:49:58.856038Z] Finished clobber step (success) 15:49:58 INFO - [mozharness: 2016-07-22 22:49:58.856138Z] Running read-buildbot-config step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: read_buildbot_config 15:49:58 INFO - Using buildbot properties: 15:49:58 INFO - { 15:49:58 INFO - "project": "", 15:49:58 INFO - "product": "firefox", 15:49:58 INFO - "script_repo_revision": "production", 15:49:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:49:58 INFO - "repository": "", 15:49:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:49:58 INFO - "buildid": "20160722153026", 15:49:58 INFO - "pgo_build": "False", 15:49:58 INFO - "basedir": "/builds/slave/test", 15:49:58 INFO - "buildnumber": 92, 15:49:58 INFO - "slavename": "talos-linux64-ix-015", 15:49:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:49:58 INFO - "platform": "ubuntu64_hw", 15:49:58 INFO - "scheduler": "tests-autoland-linux64-talos", 15:49:58 INFO - "branch": "autoland", 15:49:58 INFO - "repo_path": "integration/autoland", 15:49:58 INFO - "revision": "933fcf81f9c8661398b077014802441440a84955", 15:49:58 INFO - "stage_platform": "linux64", 15:49:58 INFO - "builduid": "5e8db03a220244e491e2ea801fa6699f", 15:49:58 INFO - "slavebuilddir": "test" 15:49:58 INFO - } 15:49:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:49:58 INFO - Running post-action listener: _resource_record_post_action 15:49:58 INFO - [mozharness: 2016-07-22 22:49:58.858599Z] Finished read-buildbot-config step (success) 15:49:58 INFO - [mozharness: 2016-07-22 22:49:58.858688Z] Running download-and-extract step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: download_and_extract 15:49:58 INFO - mkdir: /builds/slave/test/build/tests 15:49:58 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')]} 15:49:58 INFO - https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:49:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:49:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:49:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:02 INFO - Downloaded 1361 bytes. 15:50:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:50:02 INFO - Using the following test package requirements: 15:50:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'jsshell-linux-x86_64.zip'], 15:50:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:02 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')]} 15:50:02 INFO - https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:03 INFO - Downloaded 22737819 bytes. 15:50:03 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'] 15:50:03 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 15:50:04 INFO - Return code: 0 15:50:04 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 15:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:04 INFO - https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:16 INFO - Downloaded 22737819 bytes. 15:50:16 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'] 15:50:16 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 15:50:17 INFO - Return code: 0 15:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:17 INFO - https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:18 INFO - Downloaded 14403248 bytes. 15:50:18 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'] 15:50:18 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 15:50:18 INFO - Return code: 0 15:50: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')]} 15:50:18 INFO - https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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 15:50:20 INFO - Downloaded 57160670 bytes. 15:50:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:20 INFO - mkdir: /builds/slave/test/properties 15:50:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:20 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:20 INFO - Contents: 15:50:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:21 INFO - Running post-action listener: _resource_record_post_action 15:50:21 INFO - Running post-action listener: set_extra_try_arguments 15:50:21 INFO - [mozharness: 2016-07-22 22:50:21.010294Z] Finished download-and-extract step (success) 15:50:21 INFO - [mozharness: 2016-07-22 22:50:21.010527Z] Running populate-webroot step. 15:50:21 INFO - Running pre-action listener: _resource_record_pre_action 15:50:21 INFO - Running main action method: populate_webroot 15:50:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:21 INFO - '--tppagecycles', 15:50:21 INFO - '7'], 15:50:21 INFO - 'tests': ['tsvgm']}}, 15:50:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:50:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['damp', 'tps']}, 15:50:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'tests': ['damp', 'tps']}, 15:50:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['dromaeo_dom']}, 15:50:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['basic_compositor_video']}, 15:50:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:50:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['a11yr', 15:50:21 INFO - 'ts_paint', 15:50:21 INFO - 'tpaint', 15:50:21 INFO - 'sessionrestore', 15:50:21 INFO - 'sessionrestore_no_auto_restore', 15:50:21 INFO - 'tabpaint']}, 15:50:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['tsvgx', 15:50:21 INFO - 'tsvgr_opacity', 15:50:21 INFO - 'tart', 15:50:21 INFO - 'tscrollx', 15:50:21 INFO - 'cart']}, 15:50:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:21 INFO - 'tsvgr_opacity', 15:50:21 INFO - 'tart', 15:50:21 INFO - 'tscrollx', 15:50:21 INFO - 'cart']}, 15:50:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'talos_options': ['--disable-e10s'], 15:50:21 INFO - 'tests': ['tp5o']}, 15:50:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'tests': ['tp5o']}, 15:50:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'talos_options': ['--disable-e10s', 15:50:21 INFO - '--xperf_path', 15:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:21 INFO - 'tests': ['tp5n']}, 15:50:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:21 INFO - 'talos_options': ['--xperf_path', 15:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:21 INFO - 'tests': ['tp5n']}}, 15:50:21 INFO - 'talos.zip': {'path': '', 15:50:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:21 INFO - Running post-action listener: _resource_record_post_action 15:50:21 INFO - [mozharness: 2016-07-22 22:50:21.028248Z] Finished populate-webroot step (success) 15:50:21 INFO - [mozharness: 2016-07-22 22:50:21.028338Z] Running create-virtualenv step. 15:50:21 INFO - Running pre-action listener: _resource_record_pre_action 15:50:21 INFO - Running main action method: create_virtualenv 15:50:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:21 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 15:50:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:50:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:21 INFO - Using real prefix '/usr' 15:50:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:23 INFO - Installing pip.................done. 15:50:23 INFO - Return code: 0 15:50:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50:23 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 15:50:23 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 15:50:23 INFO - Using env: {'DISPLAY': ':0', 15:50:23 INFO - 'HOME': '/home/cltbld', 15:50:23 INFO - 'LANG': 'en_US.UTF-8', 15:50:23 INFO - 'LANGUAGE': 'en_US:en', 15:50:23 INFO - 'LOGNAME': 'cltbld', 15:50:23 INFO - 'MAIL': '/var/mail/cltbld', 15:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:23 INFO - 'MOZ_NO_REMOTE': '1', 15:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:23 INFO - 'NO_EM_RESTART': '1', 15:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:23 INFO - 'PWD': '/builds/slave/test', 15:50:23 INFO - 'SHELL': '/bin/bash', 15:50:23 INFO - 'SHLVL': '1', 15:50:23 INFO - 'TERM': 'linux', 15:50:23 INFO - 'TMOUT': '86400', 15:50:23 INFO - 'USER': 'cltbld', 15:50:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:23 INFO - '_': '/tools/buildbot/bin/python'} 15:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:23 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 15:50:23 INFO - Cleaning up... 15:50:23 INFO - Return code: 0 15:50:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50:23 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 15:50:23 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 15:50:23 INFO - Using env: {'DISPLAY': ':0', 15:50:23 INFO - 'HOME': '/home/cltbld', 15:50:23 INFO - 'LANG': 'en_US.UTF-8', 15:50:23 INFO - 'LANGUAGE': 'en_US:en', 15:50:23 INFO - 'LOGNAME': 'cltbld', 15:50:23 INFO - 'MAIL': '/var/mail/cltbld', 15:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:23 INFO - 'MOZ_NO_REMOTE': '1', 15:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:23 INFO - 'NO_EM_RESTART': '1', 15:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:23 INFO - 'PWD': '/builds/slave/test', 15:50:23 INFO - 'SHELL': '/bin/bash', 15:50:23 INFO - 'SHLVL': '1', 15:50:23 INFO - 'TERM': 'linux', 15:50:23 INFO - 'TMOUT': '86400', 15:50:23 INFO - 'USER': 'cltbld', 15:50:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:23 INFO - '_': '/tools/buildbot/bin/python'} 15:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:24 INFO - Downloading/unpacking psutil>=3.1.1 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:24 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 15:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:26 INFO - Installing collected packages: psutil 15:50:26 INFO - Running setup.py install for psutil 15:50:26 INFO - building 'psutil._psutil_linux' extension 15:50:26 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 15:50: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 15:50:26 INFO - building 'psutil._psutil_posix' extension 15:50: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 15:50: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 15:50:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:26 INFO - Successfully installed psutil 15:50:26 INFO - Cleaning up... 15:50:26 INFO - Return code: 0 15:50:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:26 INFO - Using env: {'DISPLAY': ':0', 15:50:26 INFO - 'HOME': '/home/cltbld', 15:50:26 INFO - 'LANG': 'en_US.UTF-8', 15:50:26 INFO - 'LANGUAGE': 'en_US:en', 15:50:26 INFO - 'LOGNAME': 'cltbld', 15:50:26 INFO - 'MAIL': '/var/mail/cltbld', 15:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:26 INFO - 'MOZ_NO_REMOTE': '1', 15:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:26 INFO - 'NO_EM_RESTART': '1', 15:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:26 INFO - 'PWD': '/builds/slave/test', 15:50:26 INFO - 'SHELL': '/bin/bash', 15:50:26 INFO - 'SHLVL': '1', 15:50:26 INFO - 'TERM': 'linux', 15:50:26 INFO - 'TMOUT': '86400', 15:50:26 INFO - 'USER': 'cltbld', 15:50:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:26 INFO - '_': '/tools/buildbot/bin/python'} 15:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:28 INFO - Installing collected packages: mozsystemmonitor 15:50:28 INFO - Running setup.py install for mozsystemmonitor 15:50:28 INFO - Successfully installed mozsystemmonitor 15:50:28 INFO - Cleaning up... 15:50:29 INFO - Return code: 0 15:50:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:29 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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50:29 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 15:50:29 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 15:50:29 INFO - Using env: {'DISPLAY': ':0', 15:50:29 INFO - 'HOME': '/home/cltbld', 15:50:29 INFO - 'LANG': 'en_US.UTF-8', 15:50:29 INFO - 'LANGUAGE': 'en_US:en', 15:50:29 INFO - 'LOGNAME': 'cltbld', 15:50:29 INFO - 'MAIL': '/var/mail/cltbld', 15:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:29 INFO - 'MOZ_NO_REMOTE': '1', 15:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:29 INFO - 'NO_EM_RESTART': '1', 15:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:29 INFO - 'PWD': '/builds/slave/test', 15:50:29 INFO - 'SHELL': '/bin/bash', 15:50:29 INFO - 'SHLVL': '1', 15:50:29 INFO - 'TERM': 'linux', 15:50:29 INFO - 'TMOUT': '86400', 15:50:29 INFO - 'USER': 'cltbld', 15:50:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:29 INFO - '_': '/tools/buildbot/bin/python'} 15:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:29 INFO - Downloading/unpacking jsonschema==2.5.1 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:31 INFO - warning: no files found matching '*.txt' 15:50:31 INFO - no previously-included directories found matching 'build' 15:50:31 INFO - no previously-included directories found matching 'dist' 15:50:31 INFO - no previously-included directories found matching '.git*' 15:50:31 INFO - Installing collected packages: jsonschema, functools32 15:50:31 INFO - Running setup.py install for functools32 15:50:31 INFO - warning: no files found matching '*.txt' 15:50:31 INFO - no previously-included directories found matching 'build' 15:50:31 INFO - no previously-included directories found matching 'dist' 15:50:31 INFO - no previously-included directories found matching '.git*' 15:50:31 INFO - Successfully installed jsonschema functools32 15:50:31 INFO - Cleaning up... 15:50:31 INFO - Return code: 0 15:50:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:31 INFO - Using env: {'DISPLAY': ':0', 15:50:31 INFO - 'HOME': '/home/cltbld', 15:50:31 INFO - 'LANG': 'en_US.UTF-8', 15:50:31 INFO - 'LANGUAGE': 'en_US:en', 15:50:31 INFO - 'LOGNAME': 'cltbld', 15:50:31 INFO - 'MAIL': '/var/mail/cltbld', 15:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:31 INFO - 'MOZ_NO_REMOTE': '1', 15:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:31 INFO - 'NO_EM_RESTART': '1', 15:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:31 INFO - 'PWD': '/builds/slave/test', 15:50:31 INFO - 'SHELL': '/bin/bash', 15:50:31 INFO - 'SHLVL': '1', 15:50:31 INFO - 'TERM': 'linux', 15:50:31 INFO - 'TMOUT': '86400', 15:50:31 INFO - 'USER': 'cltbld', 15:50:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:31 INFO - '_': '/tools/buildbot/bin/python'} 15:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:31 INFO - Cleaning up... 15:50:31 INFO - Return code: 0 15:50:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:31 INFO - Using env: {'DISPLAY': ':0', 15:50:31 INFO - 'HOME': '/home/cltbld', 15:50:31 INFO - 'LANG': 'en_US.UTF-8', 15:50:31 INFO - 'LANGUAGE': 'en_US:en', 15:50:31 INFO - 'LOGNAME': 'cltbld', 15:50:31 INFO - 'MAIL': '/var/mail/cltbld', 15:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:31 INFO - 'MOZ_NO_REMOTE': '1', 15:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:31 INFO - 'NO_EM_RESTART': '1', 15:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:31 INFO - 'PWD': '/builds/slave/test', 15:50:31 INFO - 'SHELL': '/bin/bash', 15:50:31 INFO - 'SHLVL': '1', 15:50:31 INFO - 'TERM': 'linux', 15:50:31 INFO - 'TMOUT': '86400', 15:50:31 INFO - 'USER': 'cltbld', 15:50:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:31 INFO - '_': '/tools/buildbot/bin/python'} 15:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:32 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 15:50:32 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 15:50:32 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 15:50:32 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 15:50:32 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 15:50:32 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 15:50:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:34 INFO - Downloading docopt-0.6.1.tar.gz 15:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:34 INFO - Running setup.py install for blobuploader 15:50:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:34 INFO - Running setup.py install for requests 15:50:35 INFO - Running setup.py install for docopt 15:50:35 INFO - Successfully installed blobuploader requests docopt 15:50:35 INFO - Cleaning up... 15:50:35 INFO - Return code: 0 15:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:35 INFO - Using env: {'DISPLAY': ':0', 15:50:35 INFO - 'HOME': '/home/cltbld', 15:50:35 INFO - 'LANG': 'en_US.UTF-8', 15:50:35 INFO - 'LANGUAGE': 'en_US:en', 15:50:35 INFO - 'LOGNAME': 'cltbld', 15:50:35 INFO - 'MAIL': '/var/mail/cltbld', 15:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:35 INFO - 'MOZ_NO_REMOTE': '1', 15:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:35 INFO - 'NO_EM_RESTART': '1', 15:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:35 INFO - 'PWD': '/builds/slave/test', 15:50:35 INFO - 'SHELL': '/bin/bash', 15:50:35 INFO - 'SHLVL': '1', 15:50:35 INFO - 'TERM': 'linux', 15:50:35 INFO - 'TMOUT': '86400', 15:50:35 INFO - 'USER': 'cltbld', 15:50:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:35 INFO - '_': '/tools/buildbot/bin/python'} 15:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:35 INFO - Running setup.py (path:/tmp/pip-YWN6P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:35 INFO - Running setup.py (path:/tmp/pip-kUMmud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:35 INFO - Running setup.py (path:/tmp/pip-y6z4tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:35 INFO - Running setup.py (path:/tmp/pip-SXbzoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:35 INFO - Running setup.py (path:/tmp/pip-01WwVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:35 INFO - Running setup.py (path:/tmp/pip-ODvGel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:35 INFO - Running setup.py (path:/tmp/pip-Z3qm1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:36 INFO - Running setup.py (path:/tmp/pip-RsixHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:36 INFO - Running setup.py (path:/tmp/pip-yPRTPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:36 INFO - Running setup.py (path:/tmp/pip-CZgMZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:36 INFO - Running setup.py (path:/tmp/pip-b1DbEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:36 INFO - Running setup.py (path:/tmp/pip-wx2PqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:36 INFO - Running setup.py (path:/tmp/pip-SDkEPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:36 INFO - Running setup.py (path:/tmp/pip-1fElUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:36 INFO - Running setup.py (path:/tmp/pip-GuaKT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:36 INFO - Running setup.py (path:/tmp/pip-ECmfjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:36 INFO - Running setup.py (path:/tmp/pip-00gGIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:36 INFO - Running setup.py install for manifestparser 15:50:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:36 INFO - Running setup.py install for mozcrash 15:50:36 INFO - Running setup.py install for mozdebug 15:50:37 INFO - Running setup.py install for mozdevice 15:50:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for mozfile 15:50:37 INFO - Running setup.py install for mozhttpd 15:50:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for mozinfo 15:50:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for mozInstall 15:50:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for mozleak 15:50:37 INFO - Running setup.py install for mozlog 15:50:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for moznetwork 15:50:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:37 INFO - Running setup.py install for mozprocess 15:50:37 INFO - Running setup.py install for mozprofile 15:50:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:38 INFO - Running setup.py install for mozrunner 15:50:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:38 INFO - Running setup.py install for mozscreenshot 15:50:38 INFO - Running setup.py install for moztest 15:50:38 INFO - Running setup.py install for mozversion 15:50:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:38 INFO - Cleaning up... 15:50:38 INFO - Return code: 0 15:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:38 INFO - Using env: {'DISPLAY': ':0', 15:50:38 INFO - 'HOME': '/home/cltbld', 15:50:38 INFO - 'LANG': 'en_US.UTF-8', 15:50:38 INFO - 'LANGUAGE': 'en_US:en', 15:50:38 INFO - 'LOGNAME': 'cltbld', 15:50:38 INFO - 'MAIL': '/var/mail/cltbld', 15:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:38 INFO - 'MOZ_NO_REMOTE': '1', 15:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:38 INFO - 'NO_EM_RESTART': '1', 15:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:38 INFO - 'PWD': '/builds/slave/test', 15:50:38 INFO - 'SHELL': '/bin/bash', 15:50:38 INFO - 'SHLVL': '1', 15:50:38 INFO - 'TERM': 'linux', 15:50:38 INFO - 'TMOUT': '86400', 15:50:38 INFO - 'USER': 'cltbld', 15:50:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:38 INFO - '_': '/tools/buildbot/bin/python'} 15:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:38 INFO - Running setup.py (path:/tmp/pip-gmJ8Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50: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)) 15:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:38 INFO - Running setup.py (path:/tmp/pip-hB80dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50: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)) 15:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:38 INFO - Running setup.py (path:/tmp/pip-LTHpAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50: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)) 15:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:38 INFO - Running setup.py (path:/tmp/pip-NEs2A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:39 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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:39 INFO - Running setup.py (path:/tmp/pip-YSCXEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:39 INFO - Running setup.py (path:/tmp/pip-eVwpbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:39 INFO - Running setup.py (path:/tmp/pip-FJ6mmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:39 INFO - Running setup.py (path:/tmp/pip-g3M4UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:39 INFO - Running setup.py (path:/tmp/pip-ixVEzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:39 INFO - Running setup.py (path:/tmp/pip-jr_w2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:39 INFO - Running setup.py (path:/tmp/pip-CT_tOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:39 INFO - Running setup.py (path:/tmp/pip-EK62dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:39 INFO - Running setup.py (path:/tmp/pip-Pe9xfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:39 INFO - Running setup.py (path:/tmp/pip-lA2vzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:39 INFO - Running setup.py (path:/tmp/pip-pnVdOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:39 INFO - Running setup.py (path:/tmp/pip-MIVs7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50: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)) 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:39 INFO - Running setup.py (path:/tmp/pip-I2eK6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:40 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)) 15:50:40 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)) 15:50:40 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)) 15:50:40 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)) 15:50:40 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)) 15:50:40 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)) 15:50:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:41 INFO - Downloading blessings-1.6.tar.gz 15:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:41 INFO - Installing collected packages: blessings 15:50:41 INFO - Running setup.py install for blessings 15:50:42 INFO - Successfully installed blessings 15:50:42 INFO - Cleaning up... 15:50:42 INFO - Return code: 0 15:50:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:42 INFO - Reading from file tmpfile_stdout 15:50:42 INFO - Current package versions: 15:50:42 INFO - argparse == 1.2.1 15:50:42 INFO - blessings == 1.6 15:50:42 INFO - blobuploader == 1.2.4 15:50:42 INFO - docopt == 0.6.1 15:50:42 INFO - functools32 == 3.2.3-2 15:50:42 INFO - jsonschema == 2.5.1 15:50:42 INFO - manifestparser == 1.1 15:50:42 INFO - mozInstall == 1.12 15:50:42 INFO - mozcrash == 0.17 15:50:42 INFO - mozdebug == 0.1 15:50:42 INFO - mozdevice == 0.48 15:50:42 INFO - mozfile == 1.2 15:50:42 INFO - mozhttpd == 0.7 15:50:42 INFO - mozinfo == 0.9 15:50:42 INFO - mozleak == 0.1 15:50:42 INFO - mozlog == 3.3 15:50:42 INFO - moznetwork == 0.27 15:50:42 INFO - mozprocess == 0.23 15:50:42 INFO - mozprofile == 0.28 15:50:42 INFO - mozrunner == 6.12 15:50:42 INFO - mozscreenshot == 0.1 15:50:42 INFO - mozsystemmonitor == 0.3 15:50:42 INFO - moztest == 0.7 15:50:42 INFO - mozversion == 1.4 15:50:42 INFO - psutil == 3.1.1 15:50:42 INFO - requests == 1.2.3 15:50:42 INFO - wsgiref == 0.1.2 15:50:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:42 INFO - Using env: {'DISPLAY': ':0', 15:50:42 INFO - 'HOME': '/home/cltbld', 15:50:42 INFO - 'LANG': 'en_US.UTF-8', 15:50:42 INFO - 'LANGUAGE': 'en_US:en', 15:50:42 INFO - 'LOGNAME': 'cltbld', 15:50:42 INFO - 'MAIL': '/var/mail/cltbld', 15:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:42 INFO - 'MOZ_NO_REMOTE': '1', 15:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:42 INFO - 'NO_EM_RESTART': '1', 15:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:42 INFO - 'PWD': '/builds/slave/test', 15:50:42 INFO - 'SHELL': '/bin/bash', 15:50:42 INFO - 'SHLVL': '1', 15:50:42 INFO - 'TERM': 'linux', 15:50:42 INFO - 'TMOUT': '86400', 15:50:42 INFO - 'USER': 'cltbld', 15:50:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:42 INFO - '_': '/tools/buildbot/bin/python'} 15:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50: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)) 15:50:42 INFO - Cleaning up... 15:50:42 INFO - Return code: 0 15:50:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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 0x115c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', '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 15:50: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 15:50: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 15:50:42 INFO - Using env: {'DISPLAY': ':0', 15:50:42 INFO - 'HOME': '/home/cltbld', 15:50:42 INFO - 'LANG': 'en_US.UTF-8', 15:50:42 INFO - 'LANGUAGE': 'en_US:en', 15:50:42 INFO - 'LOGNAME': 'cltbld', 15:50:42 INFO - 'MAIL': '/var/mail/cltbld', 15:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:42 INFO - 'MOZ_NO_REMOTE': '1', 15:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:42 INFO - 'NO_EM_RESTART': '1', 15:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:42 INFO - 'PWD': '/builds/slave/test', 15:50:42 INFO - 'SHELL': '/bin/bash', 15:50:42 INFO - 'SHLVL': '1', 15:50:42 INFO - 'TERM': 'linux', 15:50:42 INFO - 'TMOUT': '86400', 15:50:42 INFO - 'USER': 'cltbld', 15:50:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:42 INFO - '_': '/tools/buildbot/bin/python'} 15:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:42 INFO - Cleaning up... 15:50:42 INFO - Return code: 0 15:50:42 INFO - Running post-action listener: _resource_record_post_action 15:50:42 INFO - Running post-action listener: _start_resource_monitoring 15:50:42 INFO - Starting resource monitoring. 15:50:42 INFO - [mozharness: 2016-07-22 22:50:42.836635Z] Finished create-virtualenv step (success) 15:50:42 INFO - [mozharness: 2016-07-22 22:50:42.837061Z] Running install step. 15:50:42 INFO - Running pre-action listener: _resource_record_pre_action 15:50:42 INFO - Running main action method: install 15:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:43 INFO - Reading from file tmpfile_stdout 15:50:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:43 INFO - Reading from file tmpfile_stdout 15:50:43 INFO - Output received: 15:50:43 INFO - Usage: mozinstall [options] installer 15:50:43 INFO - Options: 15:50:43 INFO - -h, --help show this help message and exit 15:50:43 INFO - -d DEST, --destination=DEST 15:50:43 INFO - Directory to install application into. [default: 15:50:43 INFO - "/builds/slave/test"] 15:50:43 INFO - --app=APP Application being installed. [default: firefox] 15:50:43 INFO - mkdir: /builds/slave/test/build/application 15:50: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'] 15:50: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 15:50:59 INFO - Reading from file tmpfile_stdout 15:50:59 INFO - Output received: 15:50:59 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:59 INFO - Running post-action listener: _resource_record_post_action 15:50:59 INFO - [mozharness: 2016-07-22 22:50:59.512859Z] Finished install step (success) 15:50:59 INFO - [mozharness: 2016-07-22 22:50:59.513139Z] Running run-tests step. 15:50:59 INFO - Running pre-action listener: _resource_record_pre_action 15:50:59 INFO - Running main action method: run_tests 15:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:59 INFO - Python 2.7.3 15:50:59 INFO - Return code: 0 15:50:59 INFO - grabbing minidump binary from tooltool 15:50: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')]} 15:50: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 0x141b3b0>, '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 0x141c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50: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 15:50: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 15:50: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 15:50:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:59 INFO - Return code: 0 15:50:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 15:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 15:50:59 INFO - Using env: {'DISPLAY': ':0', 15:50:59 INFO - 'HOME': '/home/cltbld', 15:50:59 INFO - 'LANG': 'en_US.UTF-8', 15:50:59 INFO - 'LANGUAGE': 'en_US:en', 15:50:59 INFO - 'LOGNAME': 'cltbld', 15:50:59 INFO - 'MAIL': '/var/mail/cltbld', 15:50:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:59 INFO - 'MOZ_NO_REMOTE': '1', 15:50:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:59 INFO - 'NO_EM_RESTART': '1', 15:50:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:59 INFO - 'PWD': '/builds/slave/test', 15:50:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:59 INFO - 'SHELL': '/bin/bash', 15:50:59 INFO - 'SHLVL': '1', 15:50:59 INFO - 'TERM': 'linux', 15:50:59 INFO - 'TMOUT': '86400', 15:50:59 INFO - 'USER': 'cltbld', 15:50:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151', 15:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:59 INFO - '_': '/tools/buildbot/bin/python'} 15:50:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 15:50:59 INFO - mozversion application_buildid: 20160722153026 15:50:59 INFO - mozversion application_changeset: 933fcf81f9c8661398b077014802441440a84955 15:50:59 INFO - mozversion application_display_name: Nightly 15:50:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:59 INFO - mozversion application_name: Firefox 15:50:59 INFO - mozversion application_remotingname: firefox 15:50:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:50:59 INFO - mozversion application_vendor: Mozilla 15:50:59 INFO - mozversion application_version: 50.0a1 15:50:59 INFO - mozversion platform_buildid: 20160722153026 15:50:59 INFO - mozversion platform_changeset: 933fcf81f9c8661398b077014802441440a84955 15:50:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:50:59 INFO - mozversion platform_version: 50.0a1 15:50:59 INFO - using testdate: 1469227859 15:50:59 INFO - actual date: 1469227859 15:50:59 INFO - starting webserver on 'localhost:46744' 15:50:59 INFO - SUITE-START | Running 2 tests 15:50:59 INFO - TEST-START | dromaeo_css 15:50:59 INFO - operating with platform_type : linux_ 15:50:59 INFO - Initialising browser for dromaeo_css test... 15:50:59 INFO - TEST-INFO | started process 14711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUjGazY/profile http://localhost:46744/getInfo.html) 15:51:03 INFO - PROCESS | 14711 | JavaScript error: , line 0: uncaught exception: undefined 15:51:03 INFO - PROCESS | 14711 | __metrics Screen width/height:1600/1200 15:51:03 INFO - PROCESS | 14711 | colorDepth:24 15:51:03 INFO - PROCESS | 14711 | Browser inner width/height: 1024/697 15:51:03 INFO - PROCESS | 14711 | __metrics 15:51:04 INFO - PROCESS | 14711 | 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" 15:51:04 INFO - PROCESS | 14711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:05 INFO - TEST-INFO | 14711: exit 0 15:51:05 INFO - Browser initialized. 15:51:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:05 INFO - TEST-INFO | started process 14791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUjGazY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:17 INFO - PROCESS | 14791 | RSS: Main: 159023104 15:51:17 INFO - PROCESS | 14791 | 15:52:08 INFO - PROCESS | 14791 | 1469227928525 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] 15:54:21 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46744/tests/dromaeo/cssquery-ext.html) 15:54:22 INFO - PROCESS | 14791 | RSS: Main: 233803776 15:54:22 INFO - PROCESS | 14791 | 15:57:25 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-ext.html (next: http://localhost:46744/tests/dromaeo/cssquery-jquery.html) 15:57:26 INFO - PROCESS | 14791 | RSS: Main: 244314112 15:57:26 INFO - PROCESS | 14791 | 16:00:28 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46744/tests/dromaeo/cssquery-mootools.html) 16:00:28 INFO - PROCESS | 14791 | RSS: Main: 209608704 16:00:28 INFO - PROCESS | 14791 | 16:03:31 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46744/tests/dromaeo/cssquery-prototype.html) 16:03:31 INFO - PROCESS | 14791 | RSS: Main: 195231744 16:03:31 INFO - PROCESS | 14791 | 16:06:34 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46744/tests/dromaeo/cssquery-yui.html) 16:06:35 INFO - PROCESS | 14791 | RSS: Main: 187383808 16:06:35 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | Cycle 1(1): loaded http://localhost:46744/tests/dromaeo/cssquery-yui.html (next: http://localhost:46744/tests/dromaeo/cssquery-dojo.html) 16:09:38 INFO - PROCESS | 14791 | RSS: Main: 270336000 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | __start_tp_report 16:09:38 INFO - PROCESS | 14791 | _x_x_mozilla_page_load 16:09:38 INFO - PROCESS | 14791 | _x_x_mozilla_page_load_details 16:09:38 INFO - PROCESS | 14791 | |i|pagename|runs| 16:09:38 INFO - PROCESS | 14791 | |0;dojo.html;2589.2879458149005;2604.3879688273264;2629.8290611110283;2637.7889768818495;2643.907463238786;4630.166570017395;4707.270373092168;4829.589484893784;4837.951620483794;4890.633202509813;4734.857954261369;4740.241561350184;4745.952540474595;4782.497837727041;4848.927266091003;4363.38912552243;4426.690131690783;4439.8446054388105;4464.084862603175;4493.2136876046725;4359.651227901776;4463.73217606943;4480.081583275437;4497.25795243786;4542.386777785006;4496.280595104784;4520.886977825564;4524.502304746476;4531.410916580857;4537.160625284333;4320.071184695305;4343.4787825460835;4376.0591472833175;4404.075144219718;4444.155610434007;4359.869203923888;4363.694541382105;4367.192069467159;4376.343548467724;4417.712848664826;4829.855104346875;4841.951580484185;4854.927176092326;4881.316615673809;4889.07107649549;4995.950040499585;5008.398992120932;5127.384713834326;5141.2288156776785;5195;5012.573931215851;5033.84898453047;5073.949260507421;5080.542751152377;5128;4732.692374995614;4733.5266473352385;4740.170470167707;4763.2140696784645;4768.213244814636;5091.974540127276;5182.97408512955;5200;5287.127623942083;5287.4448182941005;5076.340075790124;5091.592672586185;5096.847094587169;5098.2352647103235;5106.719130447861;5126.641135120581;5138.075146473596;5142.97428512855;5184.714840683799;5195.350581177353;4898.90202195954;5004.47453017428;5060.1903695408555;5071.644984851099;5103.438621751604;5096.464871188546;5151.845444636667;5165.096108181053;5165.690058596496;5168.483151684876;4362.672799540047;4371.038371558252;4371.803268852909;4373.825046998148;4414.381986521889;3719.423489359154;3800.8859734208017;3853.9614603854166;3857.787821669835;3859.96140038596;4272.636825869836;4310.913781724411;4369.300911854088;4375.059362237134;4422.624076953431;5130.897382052338;5132.127538318495;5139.049275883974;5139.897202055938;5189.792408303701;4327.415798867176;4365.519792822787;4367.650587952956;4369.475662920407;4406.823727050882;4476.910461790746;4517.164324599894;4551.294549344857;4565.497795242521;4615.076984603093;4693.5071817458675;4724.811007559659;4725.527447255385;4731.408573928259;4774.427068751772;5045.2936588876855;5073.213651883964;5081.898362032664;5100.362454693163;5150.0987327216835;4641.419822522184;4703.788329525248;4729.739864307358;4760.476347601831;4829.396325459317;5019.272205530251;5053.7473126344275;5059.392872855281;5062.721550314768;5104.336436263262;5085.4914508548845;5127.4872512748425;5127.79488820443;5128.9487105129965;5131.820386286462;4793.400824896888;4911.066897289504;4972.055309491185;4999.325091112653;5051.722155281494;4950.2079667253065;4953.356063711694;4961.925571116509;4969.726665033313;5012.749362531932;4900.558949694545;4902.730349830794;4932.7286999215385;4949.307097006494;4952.281919121635;4858.805647774049;4926.630502712239;4953.430355509163;4977.950220497749;5018.84943451697;4875.43932447773;4883.804647814048;4886.267059941038;4890.336547334561;4936.407631084293 16:09:38 INFO - PROCESS | 14791 | |1;ext.html;565.3177095325107;588.4262843727365;589.0810335876031;601.8916595012897;604.7973928733874;27886.44227115459;40956.38565421521;41535.99999999996;41692.37461438081;41727.582724172746;42434.78782606091;42784.572154278445;42863.35704964428;42874.35688464668;42966.7851660742;7446.627668616575;7521.661525231364;7652.7704168875025;7655.2344765523285;7665.770026899174;7450.664720087609;7657.234276572354;7718.459707820455;7721.150673425918;9812.656557020506;9850.605975760996;10186.28695991281;10188.184945204403;10197.388156710584;10200.285979981405;10029.899701003005;10081.344712593658;10093;10097.495125243746;10119.342242754197;9938.652147174815;9951.5024248788;9992.200623950066;10003.699889003268;10009.59961601535;38310.23379532422;38504;38566.807165964274;38635;38712.225755485015;2964.3626620276527;3348;3361.344537815127;3371.089805752458;3475.1833319169973;29793.404131917458;29981.55027674565;30067.248318791986;30207.09378718642;31315.843420782978;3295.884644037471;3314.386838434897;3338.315645292709;3444.4144495435835;3469.2020835208045;252668;253745;255606;255609;255993.7200314005;33585.664143358255;54125.45874541283;54399.728001360534;54525.1821222682;54538.45461545413;34137;34311.142221444665;34368;34393.140171495914;34411.4838277426;12664.303463309423;12692.746145077232;12693.365331733376;12694.365281735876;12701.36493175356;11814.822777658343;11899.762004759856;11931;11938.52245910154;11941.820872686916;7391.186969433358;7699.11460182075;7930.365570754326;7952.204779522117;8057.6374063167295;3080.922976925595;3084.383123375334;3094.5512900629283;3106.6116735408073;3140.262038420969;773.7485317271909;774.8721460958991;885.3758100539104;996.1283876607968;1014.9289549731595;27879.442411152068;28193.43613127726;28564.857175713987;28641.713582864322;28843.56734648982;931.2689538712078;934.5374039850318;945.1682519382899;946.1329048957894;959.9808003839884;14875.47935822241;15041.849581504264;15082.396704131932;15087.54737357859;15297;411011;414516;416400;416580;416638;48923.510764892606;49279;49341.75329123331;49483.25775113376;49507.50492495029;1082.1505118482112;1152.7982603044434;1167.754771497978;1189.2210602055668;1228.2139430764319;28414.147575572766;29355.41289174162;29849.5522567166;29880.551791722708;30438.23904402319;43724;44514;44626.330605040304;44627;44636.77681611701;321147;324442;324724;324933;325869.3706531452;26290.342741430853;27340.179794606192;27342.316442089108;27589.172324830288;27672.584911225946;42309.1538169241;42659.57340426556;43036;43092;43538.56461435472;36555.45166822553;36610.45084323684;37096.443553347264;37739;37828;36578.26843463169;37348.439773402875;37350.81324593468;37888;38996;36051.278974420886;36737.448938265414;37002.62997369992;37198.814005929795;37494.250114998096;31253;33520.49719254262;33968.490472643425;34006;34042.14894627654;25550.744492554837;25624.359391014626;25652;26063.73936260689;26320 16:09:38 INFO - PROCESS | 14791 | |2;jquery.html;345.8063484448707;370.10619354259467;370.4572800846759;379.8233821273108;384.3235904807538;12312.507499700012;16063.437779677713;16605.501834944942;17934.820651793478;18023.279068837262;15147.166905820175;15261.77107343388;17643.47069587911;17776.11119444029;17798.19908104135;4958.454569997298;4979.327790748239;5117;5155.381354237496;5157.5358217760395;3795.867144649938;5056.3173971513925;5138.177891537355;5742.569307301969;6087.573869829113;6108.725107370156;6119.5410344224365;6120.1125836753645;6126.23422072241;6128.080787881809;6002.939970600325;6067.635941843503;6071.848203794918;6115.510759139258;6169.5064394848305;5207.4792520748;5387.380451248078;5396.460353964611;5399.78400863965;5400.324959380077;21331.68002479964;21432.785672143236;21485.355439336843;21575.67636485454;21670;1808.439383791029;1876.5590086329837;1878.1736036144052;1918.6258679557493;2409.024345140221;12407.75184496305;13085.86914130856;13461.865381346257;13551.728965420734;13554.864451355557;1702.3190723710616;1714.2714346402854;1782.9926091758116;1797.0655259265109;1816.9636607267912;67896.3210367895;70608.6469567654;72254.63872680656;72799;73019;9667.323287369958;9782.804343913223;9902.455364954852;9969;10040.548175331982;13285.73428531424;13301.73396532064;13391.397387117602;13417.194968301737;13442.731145377038;7458.4033277337685;7515.924840751632;7704.152543220242;7812.882806757903;7863.405076324799;7520.135184453858;7536.237655304268;7653.15815260321;7790.454668173174;7798.064232292048;6191.566590338633;6210.223722034746;6282.968585157045;6302.464290535264;6394.0408938659575;1749.6413235286736;1755.1399814091003;1784.3397942761262;1787.8212178782019;1822.3166312632763;830.0537387378394;895.5696515689797;896.5069211933411;991.6231831903974;992.1814503035025;17079.743803842954;17379.47861564155;18108.185131669106;18109.818901811075;18274.908625457054;865.8441480533564;888.8089060851947;891.9420237684529;902.0888902208685;929.4934260827865;9779.706608801747;9933.950330248446;10329.84505232422;10368.170546356274;10400.29966287926;391611;391863;392920;395169;395568;42799.572004280184;59785.10322345168;70154;72674.2732572678;73042;882.6778225947482;906.1346414174448;958.769895225141;971.955148215671;982.2583949118513;15463.5360939172;15553.76669349938;15766.842331576996;16038.759418608497;16062.598435039217;36344.84101816306;36747.81626091959;37329.25341493101;37590.248195036496;37947.24105517929;47397.52602473931;47642.761786190844;47769.52230477651;47824;48270.75864620795;7089.858202836018;7225;7240.637968101469;7253.963730181315;7699.461037727306;11571.537138514364;12463.875361246271;12532.561360352343;12575.748485030432;12924.224546527239;10021;10241.795164096826;10492.213084018882;10571.2600117991;10696.946515267375;10576.788464230825;10813.080888124283;10936.56253749841;11019;11035.72410689707;10104.69685909424;10263.58945642166;10354.17166626653;10593.258471906893;10699.465026748787;7204.027456293543;7297.306755858185;7435.4795164337975;7484.588347640932;7623.199564045917;9783.9021609783;9834;10104.393736375841;10276.22928280397;10726.463676815973 16:09:38 INFO - PROCESS | 14791 | |3;mootools.html;1278.4694351843984;1350.1156742333771;1421.0336970859814;1446.6383404148962;1708.1630001299368;6679.833004174892;7483.9251607483975;7712.0745510538745;7772.766816995485;8024.11734709183;7796.103448103469;7856.214378562141;7867.0559532856;7868.4098692598145;7871.094824095231;2198.505336299328;2230.9180047676946;2234.028197733983;2235.9552808943813;2236.463248820288;2145.2491627930176;2170.739511258651;2214.3356992902145;2217.2683014605223;2219.9223027194053;2171.0447403142643;2171.543975765091;2178.9564208715815;2183.3122566391617;2215.7341119065736;2158.9136434542756;2165.783421657837;2169.5552411755552;2171.0772921508296;2173.815225705817;2123.3417640531484;2163.610550100981;2164.6103701333755;2168.6638571021517;2169.6962425260476;7844.37245020397;7862.882056769153;7902.130765615778;7912.762617121495;7951.324137448324;4471.217536931024;4607.631389488833;4635.930461043054;4697.812087516495;4703.129920964632;2839.5030869597736;2924.225080353708;2945.779066570016;2948.115565330392;2956.2609347663083;959.7936443664576;968.3028219681818;969.5055521683992;984.2667212926344;987.5407935310044;10706.518206680717;10760.892391076068;10805.675829725122;10855.294405863593;10858.891411085868;4080.7959602019782;4221.02916329246;4313.762743049162;4480.215962206601;4481.932771008437;8459.746207613782;8617.482951022834;8628.956855215809;8630.180132887366;8633.179847914438;4779.187538118528;4781.11549363362;4781.139394908881;4781.497942715965;4782.450018247877;3628.292482965849;3740.8690695825517;4167.874673838047;4417.359482875029;4428.31361139024;3430.091025878144;3447.775894566845;3558.057114864563;3575.1955809942556;3579.284143171376;1048.2452634103433;1069.6951368859839;1082.0856376361962;1086.9130469562417;1090.6346373964811;866.3372520022189;889.2530274569393;892.3307519360479;894.9060348663427;927.4435338796668;5242.16125419931;5347.41178470368;5375.086235340002;5475.123980163235;5504.174373843955;405.6146660672314;406.6705968165795;411.1940596431029;419.73976134796624;425.78072292768627;3699.2601479704167;3703.4629978652943;3720.4419337099653;3823.636754508317;3897.006263402814;9566;9855.950720246496;9948.054934781185;9948.253880958813;9952.601895924226;9864.901350986398;9870.457124858058;9876.111149996535;9876.703698889045;9890.159336456481;7307.707691692272;7443.590602516805;7446.143693475211;7557.2820582044615;7569.621518924032;5477.287952566141;5484.369297530835;5497.587680923867;5528.391876893619;5727.914081288701;9067.183953444222;9137.177654011171;9158.40470369424;9168.633254669738;9205.76985575366;8046.9538959934835;8526.232639062515;8541.914580854113;8935.642574296955;8962.058983806606;6509.7396104155305;6619.900701489385;6751.662416879235;6793.762218322335;6794.3545363190415;7191.532550384418;7210.351068403869;7218.169910460364;7274.454415918933;7293.9635301823155;6885.586864788129;6934.479914006369;6957.652117394009;6958.582485050913;6964.4080253179045;6692.464602831665;6766.323367663194;6796.2524122347495;6805.3875151236625;6838.281980391987;6256.843578910563;6305.90541141874;6334.3665633436285;6347.5556711029785;6347.936520634919;4573.931391029204;4757.26262429324;4758.1911075118005;4784.258439941815;4789.425268967746;4615.030843522898;4645.256758918556;4713.7643117844655;4779.115863565252;4845.49122342149 16:09:38 INFO - PROCESS | 14791 | |4;prototype.html;292.24600530630977;297.3280386326901;300.7999680212659;300.97291243788084;303.4250096067951;4811.374521312229;4862.246351815475;4865.902681946363;4866.732329721873;4867.926981095277;4545.181867263891;4640.7215567066;4683.76581170941;4761.69049011814;4813.157697402958;3811.752236104658;3818.8854334369876;3828.3300422426105;3829.6936245100464;3833.195029043904;3812.809359532026;3822.0253835271965;3826.8086595670243;3827.913786986085;3842.634949679776;3601.873934412296;3662.6154253803365;3758.49260349852;3786.129190286236;3790.639889210521;3771.849126034955;3780.1305699689087;3780.5652349979828;3782.130110074698;3804.7907365094907;3345.3476572068457;3363.4786608075788;3367.6295607483157;3368.528406023159;3370.898873033813;4472.306792447176;4702.365180700596;4716.985848042653;4733.881652958669;4734.313524538922;4235.618794308496;4251.59609837065;4255.425517555122;4260.062786187033;4273.273543497613;5021.372328458942;5025.748712564357;5026.648134630577;5040.117979353635;5048.924266136011;3569.303985722785;3569.660882216185;3594.370985077601;3597.4963505109304;3598.442241452579;4989.975050124726;5183.896322073575;5230.764615592308;5233.717739153932;5245.344331958467;3767.1712223311374;3779.225258821935;3785.5835858055593;3787.5265591801026;3793.734438589272;3845.673117784964;3858.2090671412293;3861.942070868939;3867.671247943956;3872.4191371294532;4111.157212771374;4316.870493885189;4334.371516130206;4339.891502712458;4346.587359108303;4986.775595098156;5007.949920500749;5020.7740651670765;5021.84934451967;5024.171011783088;1251.8059700746217;1295.7084655952524;1314.3559655768795;1315.329182117108;1320.7094439223356;864.4035615425462;907.7367563406671;937.5640327247862;938.2634631813993;941.0332405273012;4402.669799764966;4403.889902752393;4406.942333839856;4414.536473670282;4425.513193548707;5130.692158470503;5140.871478213075;5156.1492353761205;5166.844994650167;5167.250748641502;4300.569943005675;4375.234333991539;4391.077873646506;4403.207422663952;4410.911781764346;2722.224166112688;2724.264448598867;2735.083746944756;2741.3557813913712;2742.149933520615;4771.926316578742;4772.928406073912;4776.904461910743;4789.377380940525;4797.208460603962;5024.698518088853;5186.481351864859;5217.426083130853;5246.291750613695;5257.894842103136;4693.131770622445;4748.430188377417;4751.976240118777;4759.286107083896;4761.500042495488;5062.82280120194;5094.1849304111165;5105.617078719185;5136.383633963948;5146.511081447256;4835.178019736723;4967.379077615298;5085.4914508548845;5092.796288148581;5129.563987061141;4840.419149702058;4845.466998630219;4855.955969466581;4863.294822250825;4867.294242334912;3653.5433070866143;3656.689181419503;3664.8350824213508;3674.5774235962135;3681.4293784463453;5096.923546146885;5182.274481572658;5191.676122588716;5194.68831870089;5242.213667949838;5035.823746168867;5038.647294689336;5068.023470846447;5071.4421413645205;5076.949230507647;5042.84871453857;5043.672161309503;5059;5072.644914855925;5074.441811400817;4761.452432970253;4813.807447702053;4946.332245147003;5002.949970500248;5018.774155162953;4924.926126108039;5096.23556466533;5097.9294348187295;5103.004914041726;5110.8466745997675;4956.281339205867;4984.501549844987;4987.700737955734;4992.151334273255;4997.400311962588 16:09:38 INFO - PROCESS | 14791 | |5;yui.html;596.4780816785313;606.8634557224623;633.8890694128527;670.2928410526895;707.738136889351;12637.494500219991;13217.603471895847;13218.669533261673;13218.801717974238;13246.205227686345;12579.433925473353;12664.683382915431;12669;12679.556215532459;12691.61925142245;628.2868943748855;753.081240886118;762.1045271805621;769.7459838253363;780.9765707028798;769.6575024114271;778.9922100778977;779.4154384211841;779.575131553302;779.5946108023825;834.2575108153748;839.3620848155415;841.2176675691604;842.8904242448504;843.1526316052359;660.7489154121452;797.0952968380872;828.349745449819;834.2825170353491;834.4742812028413;610.700756629253;610.8503416662902;611.1108337369117;611.1657587393221;611.1932249430753;12444.75110497794;12522.874771252262;12528.624141275777;12545.74908501825;12560.560380386734;12218.389080545938;12430.254184748945;12516.435445569305;13020.414081366267;13061;11199.824018478106;11235.66293011211;11281.210315277935;11289.661310160709;11715.707107322385;4061.97969010156;4073.348264277701;4076.449679293317;4089.8364065437645;4220.155968806251;61037;61853;62158.37841621571;62255.6887215561;62583.687081565215;10161.339512931636;10246.180305575535;10260.076593106656;10267.0759631632;10390.688279351632;19143.712844307345;19184.424467266006;19204.903975480032;19216;19221.519462013563;6607.603543787388;6632;6831.658417079127;6848.14398200225;7028.613426261605;3625.4743062255825;3669.7064234861145;3683.3369993401443;3701.8704345348324;3736.2637362637256;2761.8757155928033;2870.6124673169275;2873.741363277315;2882.567614857788;2883.1062370665163;547.1273319056099;560.7897038610521;561.0994354061754;567.2059117235902;581.7905554000556;578.3522454850511;607.2530787131852;612.2713970375239;618.4094190048493;622.6699849079995;7968.442209045427;8193.139720329398;8230.42387032902;8293.751187464386;8383.371247156487;496.39439883342266;547.3814589513823;592.4934181274948;594.402625361509;600.2886579403333;3768.1521657626813;3957.980210098931;3979.5821438749094;3984.382420724792;4095.2014357200655;89643;100458;105216.47391762992;106107;110135.44932275287;93787;93932.53033734788;95190.52404737932;95405.5229723847;96384.51807740917;77894.22105778984;78007;78502;82189.58905205555;82509.58745206236;6322.810315690536;7442.813929651802;7588.582627955516;7648.694052237848;8014.9355259954655;43577.346339804295;44213.33679994867;45040.77479612581;45852.31221531613;46604.06791864076;64941.675291623236;66556.66721666361;66992.29100216941;67542.3245767536;68173.65913170403;8042.396820238622;8245.257926786619;8447.281981031681;8503.0221524523;8537.658493660185;10689.625863095065;10774.353538787698;10884.836727448936;11963.282203067844;12268.754624907631;7377.631118444164;9859.852102218329;9960.252981026597;10369.481525923522;11707.239029463057;11151.83272250933;11224.214304998899;11340.489677964677;11455.484503197542;12159.392030398622;11476.13928955315;11553.364564949008;11569.479373428385;11597.76804463923;12018.879811201776;10087.546060427445;10197.847032294374;10417.427041512487;10535.841962370723;10631.840522392016;10065.849012264676;10300.381977081099;10307.845382319421;10453.843192352273;10487.475626218811 16:09:38 INFO - PROCESS | 14791 | __end_tp_report 16:09:38 INFO - PROCESS | 14791 | __start_cc_report 16:09:38 INFO - PROCESS | 14791 | _x_x_mozilla_cycle_collect,1098 16:09:38 INFO - PROCESS | 14791 | __end_cc_report 16:09:38 INFO - PROCESS | 14791 | __startTimestamp1469228978491__endTimestamp 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | ------- Summary: start ------- 16:09:38 INFO - PROCESS | 14791 | Number of tests: 6 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#0] dojo.html Cycles:165 Average:4720.67 Median:4854.93 stddev:496.36 (10.2%) stddev-sans-first:468.88 16:09:38 INFO - PROCESS | 14791 | Values: 2589.3 2604.4 2629.8 2637.8 2643.9 4630.2 4707.3 4829.6 4838.0 4890.6 4734.9 4740.2 4746.0 4782.5 4848.9 4363.4 4426.7 4439.8 4464.1 4493.2 4359.7 4463.7 4480.1 4497.3 4542.4 4496.3 4520.9 4524.5 4531.4 4537.2 4320.1 4343.5 4376.1 4404.1 4444.2 4359.9 4363.7 4367.2 4376.3 4417.7 4829.9 4842.0 4854.9 4881.3 4889.1 4996.0 5008.4 5127.4 5141.2 5195.0 5012.6 5033.8 5073.9 5080.5 5128.0 4732.7 4733.5 4740.2 4763.2 4768.2 5092.0 5183.0 5200.0 5287.1 5287.4 5076.3 5091.6 5096.8 5098.2 5106.7 5126.6 5138.1 5143.0 5184.7 5195.4 4898.9 5004.5 5060.2 5071.6 5103.4 5096.5 5151.8 5165.1 5165.7 5168.5 4362.7 4371.0 4371.8 4373.8 4414.4 3719.4 3800.9 3854.0 3857.8 3860.0 4272.6 4310.9 4369.3 4375.1 4422.6 5130.9 5132.1 5139.0 5139.9 5189.8 4327.4 4365.5 4367.7 4369.5 4406.8 4476.9 4517.2 4551.3 4565.5 4615.1 4693.5 4724.8 4725.5 4731.4 4774.4 5045.3 5073.2 5081.9 5100.4 5150.1 4641.4 4703.8 4729.7 4760.5 4829.4 5019.3 5053.7 5059.4 5062.7 5104.3 5085.5 5127.5 5127.8 5128.9 5131.8 4793.4 4911.1 4972.1 4999.3 5051.7 4950.2 4953.4 4961.9 4969.7 5012.7 4900.6 4902.7 4932.7 4949.3 4952.3 4858.8 4926.6 4953.4 4978.0 5018.8 4875.4 4883.8 4886.3 4890.3 4936.4 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#1] ext.html Cycles:180 Average:48011.18 Median:18927.95 stddev:89143.44 (471.0%) stddev-sans-first:89322.33 16:09:38 INFO - PROCESS | 14791 | Values: 565.3 588.4 589.1 601.9 604.8 27886.4 40956.4 41536.0 41692.4 41727.6 42434.8 42784.6 42863.4 42874.4 42966.8 7446.6 7521.7 7652.8 7655.2 7665.8 7450.7 7657.2 7718.5 7721.2 9812.7 9850.6 10186.3 10188.2 10197.4 10200.3 10029.9 10081.3 10093.0 10097.5 10119.3 9938.7 9951.5 9992.2 10003.7 10009.6 38310.2 38504.0 38566.8 38635.0 38712.2 2964.4 3348.0 3361.3 3371.1 3475.2 29793.4 29981.6 30067.2 30207.1 31315.8 3295.9 3314.4 3338.3 3444.4 3469.2 252668.0 253745.0 255606.0 255609.0 255993.7 33585.7 54125.5 54399.7 54525.2 54538.5 34137.0 34311.1 34368.0 34393.1 34411.5 12664.3 12692.7 12693.4 12694.4 12701.4 11814.8 11899.8 11931.0 11938.5 11941.8 7391.2 7699.1 7930.4 7952.2 8057.6 3080.9 3084.4 3094.6 3106.6 3140.3 773.7 774.9 885.4 996.1 1014.9 27879.4 28193.4 28564.9 28641.7 28843.6 931.3 934.5 945.2 946.1 960.0 14875.5 15041.8 15082.4 15087.5 15297.0 411011.0 414516.0 416400.0 416580.0 416638.0 48923.5 49279.0 49341.8 49483.3 49507.5 1082.2 1152.8 1167.8 1189.2 1228.2 28414.1 29355.4 29849.6 29880.6 30438.2 43724.0 44514.0 44626.3 44627.0 44636.8 321147.0 324442.0 324724.0 324933.0 325869.4 26290.3 27340.2 27342.3 27589.2 27672.6 42309.2 42659.6 43036.0 43092.0 43538.6 36555.5 36610.5 37096.4 37739.0 37828.0 36578.3 37348.4 37350.8 37888.0 38996.0 36051.3 36737.4 37002.6 37198.8 37494.3 31253.0 33520.5 33968.5 34006.0 34042.1 25550.7 25624.4 25652.0 26063.7 26320.0 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#2] jquery.html Cycles:180 Average:24305.84 Median:394044.50 stddev:64647.86 (16.4%) stddev-sans-first:64804.19 16:09:38 INFO - PROCESS | 14791 | Values: 345.8 370.1 370.5 379.8 384.3 12312.5 16063.4 16605.5 17934.8 18023.3 15147.2 15261.8 17643.5 17776.1 17798.2 4958.5 4979.3 5117.0 5155.4 5157.5 3795.9 5056.3 5138.2 5742.6 6087.6 6108.7 6119.5 6120.1 6126.2 6128.1 6002.9 6067.6 6071.8 6115.5 6169.5 5207.5 5387.4 5396.5 5399.8 5400.3 21331.7 21432.8 21485.4 21575.7 21670.0 1808.4 1876.6 1878.2 1918.6 2409.0 12407.8 13085.9 13461.9 13551.7 13554.9 1702.3 1714.3 1783.0 1797.1 1817.0 67896.3 70608.6 72254.6 72799.0 73019.0 9667.3 9782.8 9902.5 9969.0 10040.5 13285.7 13301.7 13391.4 13417.2 13442.7 7458.4 7515.9 7704.2 7812.9 7863.4 7520.1 7536.2 7653.2 7790.5 7798.1 6191.6 6210.2 6283.0 6302.5 6394.0 1749.6 1755.1 1784.3 1787.8 1822.3 830.1 895.6 896.5 991.6 992.2 17079.7 17379.5 18108.2 18109.8 18274.9 865.8 888.8 891.9 902.1 929.5 9779.7 9934.0 10329.8 10368.2 10400.3 391611.0 391863.0 392920.0 395169.0 395568.0 42799.6 59785.1 70154.0 72674.3 73042.0 882.7 906.1 958.8 972.0 982.3 15463.5 15553.8 15766.8 16038.8 16062.6 36344.8 36747.8 37329.3 37590.2 37947.2 47397.5 47642.8 47769.5 47824.0 48270.8 7089.9 7225.0 7240.6 7254.0 7699.5 11571.5 12463.9 12532.6 12575.7 12924.2 10021.0 10241.8 10492.2 10571.3 10696.9 10576.8 10813.1 10936.6 11019.0 11035.7 10104.7 10263.6 10354.2 10593.3 10699.5 7204.0 7297.3 7435.5 7484.6 7623.2 9783.9 9834.0 10104.4 10276.2 10726.5 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#3] mootools.html Cycles:180 Average:5158.50 Median:5294.79 stddev:2900.53 (54.8%) stddev-sans-first:2894.01 16:09:38 INFO - PROCESS | 14791 | Values: 1278.5 1350.1 1421.0 1446.6 1708.2 6679.8 7483.9 7712.1 7772.8 8024.1 7796.1 7856.2 7867.1 7868.4 7871.1 2198.5 2230.9 2234.0 2236.0 2236.5 2145.2 2170.7 2214.3 2217.3 2219.9 2171.0 2171.5 2179.0 2183.3 2215.7 2158.9 2165.8 2169.6 2171.1 2173.8 2123.3 2163.6 2164.6 2168.7 2169.7 7844.4 7862.9 7902.1 7912.8 7951.3 4471.2 4607.6 4635.9 4697.8 4703.1 2839.5 2924.2 2945.8 2948.1 2956.3 959.8 968.3 969.5 984.3 987.5 10706.5 10760.9 10805.7 10855.3 10858.9 4080.8 4221.0 4313.8 4480.2 4481.9 8459.7 8617.5 8629.0 8630.2 8633.2 4779.2 4781.1 4781.1 4781.5 4782.5 3628.3 3740.9 4167.9 4417.4 4428.3 3430.1 3447.8 3558.1 3575.2 3579.3 1048.2 1069.7 1082.1 1086.9 1090.6 866.3 889.3 892.3 894.9 927.4 5242.2 5347.4 5375.1 5475.1 5504.2 405.6 406.7 411.2 419.7 425.8 3699.3 3703.5 3720.4 3823.6 3897.0 9566.0 9856.0 9948.1 9948.3 9952.6 9864.9 9870.5 9876.1 9876.7 9890.2 7307.7 7443.6 7446.1 7557.3 7569.6 5477.3 5484.4 5497.6 5528.4 5727.9 9067.2 9137.2 9158.4 9168.6 9205.8 8047.0 8526.2 8541.9 8935.6 8962.1 6509.7 6619.9 6751.7 6793.8 6794.4 7191.5 7210.4 7218.2 7274.5 7294.0 6885.6 6934.5 6957.7 6958.6 6964.4 6692.5 6766.3 6796.3 6805.4 6838.3 6256.8 6305.9 6334.4 6347.6 6347.9 4573.9 4757.3 4758.2 4784.3 4789.4 4615.0 4645.3 4713.8 4779.1 4845.5 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#4] prototype.html Cycles:180 Average:4181.63 Median:4755.63 stddev:1193.53 (25.1%) stddev-sans-first:1160.62 16:09:38 INFO - PROCESS | 14791 | Values: 292.2 297.3 300.8 301.0 303.4 4811.4 4862.2 4865.9 4866.7 4867.9 4545.2 4640.7 4683.8 4761.7 4813.2 3811.8 3818.9 3828.3 3829.7 3833.2 3812.8 3822.0 3826.8 3827.9 3842.6 3601.9 3662.6 3758.5 3786.1 3790.6 3771.8 3780.1 3780.6 3782.1 3804.8 3345.3 3363.5 3367.6 3368.5 3370.9 4472.3 4702.4 4717.0 4733.9 4734.3 4235.6 4251.6 4255.4 4260.1 4273.3 5021.4 5025.7 5026.6 5040.1 5048.9 3569.3 3569.7 3594.4 3597.5 3598.4 4990.0 5183.9 5230.8 5233.7 5245.3 3767.2 3779.2 3785.6 3787.5 3793.7 3845.7 3858.2 3861.9 3867.7 3872.4 4111.2 4316.9 4334.4 4339.9 4346.6 4986.8 5007.9 5020.8 5021.8 5024.2 1251.8 1295.7 1314.4 1315.3 1320.7 864.4 907.7 937.6 938.3 941.0 4402.7 4403.9 4406.9 4414.5 4425.5 5130.7 5140.9 5156.1 5166.8 5167.3 4300.6 4375.2 4391.1 4403.2 4410.9 2722.2 2724.3 2735.1 2741.4 2742.1 4771.9 4772.9 4776.9 4789.4 4797.2 5024.7 5186.5 5217.4 5246.3 5257.9 4693.1 4748.4 4752.0 4759.3 4761.5 5062.8 5094.2 5105.6 5136.4 5146.5 4835.2 4967.4 5085.5 5092.8 5129.6 4840.4 4845.5 4856.0 4863.3 4867.3 3653.5 3656.7 3664.8 3674.6 3681.4 5096.9 5182.3 5191.7 5194.7 5242.2 5035.8 5038.6 5068.0 5071.4 5076.9 5042.8 5043.7 5059.0 5072.6 5074.4 4761.5 4813.8 4946.3 5002.9 5018.8 4924.9 5096.2 5097.9 5103.0 5110.8 4956.3 4984.5 4987.7 4992.2 4997.4 16:09:38 INFO - PROCESS | 14791 | 16:09:38 INFO - PROCESS | 14791 | [#5] yui.html Cycles:180 Average:18310.14 Median:23550.23 stddev:27174.98 (115.4%) stddev-sans-first:27218.66 16:09:38 INFO - PROCESS | 14791 | Values: 596.5 606.9 633.9 670.3 707.7 12637.5 13217.6 13218.7 13218.8 13246.2 12579.4 12664.7 12669.0 12679.6 12691.6 628.3 753.1 762.1 769.7 781.0 769.7 779.0 779.4 779.6 779.6 834.3 839.4 841.2 842.9 843.2 660.7 797.1 828.3 834.3 834.5 610.7 610.9 611.1 611.2 611.2 12444.8 12522.9 12528.6 12545.7 12560.6 12218.4 12430.3 12516.4 13020.4 13061.0 11199.8 11235.7 11281.2 11289.7 11715.7 4062.0 4073.3 4076.4 4089.8 4220.2 61037.0 61853.0 62158.4 62255.7 62583.7 10161.3 10246.2 10260.1 10267.1 10390.7 19143.7 19184.4 19204.9 19216.0 19221.5 6607.6 6632.0 6831.7 6848.1 7028.6 3625.5 3669.7 3683.3 3701.9 3736.3 2761.9 2870.6 2873.7 2882.6 2883.1 547.1 560.8 561.1 567.2 581.8 578.4 607.3 612.3 618.4 622.7 7968.4 8193.1 8230.4 8293.8 8383.4 496.4 547.4 592.5 594.4 600.3 3768.2 3958.0 3979.6 3984.4 4095.2 89643.0 100458.0 105216.5 106107.0 110135.4 93787.0 93932.5 95190.5 95405.5 96384.5 77894.2 78007.0 78502.0 82189.6 82509.6 6322.8 7442.8 7588.6 7648.7 8014.9 43577.3 44213.3 45040.8 45852.3 46604.1 64941.7 66556.7 66992.3 67542.3 68173.7 8042.4 8245.3 8447.3 8503.0 8537.7 10689.6 10774.4 10884.8 11963.3 12268.8 7377.6 9859.9 9960.3 10369.5 11707.2 11151.8 11224.2 11340.5 11455.5 12159.4 11476.1 11553.4 11569.5 11597.8 12018.9 10087.5 10197.8 10417.4 10535.8 10631.8 10065.8 10300.4 10307.8 10453.8 10487.5 16:09:38 INFO - PROCESS | 14791 | -------- Summary: end -------- 16:09:38 INFO - PROCESS | 14791 | 16:09:39 INFO - TEST-INFO | 14791: exit 0 16:09:39 INFO - TEST-OK | dromaeo_css | took 1119540ms 16:09:39 INFO - TEST-START | kraken 16:09:39 INFO - operating with platform_type : linux_ 16:09:39 INFO - Initialising browser for kraken test... 16:09:39 INFO - TEST-INFO | started process 14986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe61AZt/profile http://localhost:46744/getInfo.html) 16:09:42 INFO - PROCESS | 14986 | JavaScript error: , line 0: uncaught exception: undefined 16:09:43 INFO - PROCESS | 14986 | __metrics Screen width/height:1600/1200 16:09:43 INFO - PROCESS | 14986 | colorDepth:24 16:09:43 INFO - PROCESS | 14986 | Browser inner width/height: 1024/697 16:09:43 INFO - PROCESS | 14986 | __metrics 16:09:44 INFO - PROCESS | 14986 | 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" 16:09:44 INFO - PROCESS | 14986 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:45 INFO - TEST-INFO | 14986: exit 0 16:09:45 INFO - Browser initialized. 16:09:45 INFO - Running cycle 1/1 for kraken test... 16:09:45 INFO - TEST-INFO | started process 15064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe61AZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:57 INFO - PROCESS | 15064 | RSS: Main: 159256576 16:09:57 INFO - PROCESS | 15064 | 16:09:59 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:00 INFO - PROCESS | 15064 | RSS: Main: 215425024 16:10:00 INFO - PROCESS | 15064 | 16:10:03 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-dft) 16:10:04 INFO - PROCESS | 15064 | RSS: Main: 193744896 16:10:04 INFO - PROCESS | 15064 | 16:10:07 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-fft) 16:10:08 INFO - PROCESS | 15064 | RSS: Main: 272445440 16:10:08 INFO - PROCESS | 15064 | 16:10:10 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46744/tests/kraken/driver.html?testName=audio-oscillator) 16:10:10 INFO - PROCESS | 15064 | RSS: Main: 181964800 16:10:10 INFO - PROCESS | 15064 | 16:10:13 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:13 INFO - PROCESS | 15064 | RSS: Main: 186597376 16:10:13 INFO - PROCESS | 15064 | 16:10:16 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:17 INFO - PROCESS | 15064 | RSS: Main: 222654464 16:10:17 INFO - PROCESS | 15064 | 16:10:21 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46744/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:21 INFO - PROCESS | 15064 | RSS: Main: 222720000 16:10:21 INFO - PROCESS | 15064 | 16:10:24 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46744/tests/kraken/driver.html?testName=json-parse-financial) 16:10:25 INFO - PROCESS | 15064 | RSS: Main: 222347264 16:10:25 INFO - PROCESS | 15064 | 16:10:26 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:27 INFO - PROCESS | 15064 | RSS: Main: 186888192 16:10:27 INFO - PROCESS | 15064 | 16:10:29 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:30 INFO - PROCESS | 15064 | RSS: Main: 192704512 16:10:30 INFO - PROCESS | 15064 | 16:10:32 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:32 INFO - PROCESS | 15064 | RSS: Main: 196214784 16:10:32 INFO - PROCESS | 15064 | 16:10:35 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:36 INFO - PROCESS | 15064 | RSS: Main: 191029248 16:10:36 INFO - PROCESS | 15064 | 16:10:39 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:39 INFO - PROCESS | 15064 | RSS: Main: 194473984 16:10:39 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | Cycle 1(1): loaded http://localhost:46744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46744/tests/kraken/driver.html?testName=ai-astar) 16:10:41 INFO - PROCESS | 15064 | RSS: Main: 245542912 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | __start_tp_report 16:10:41 INFO - PROCESS | 15064 | _x_x_mozilla_page_load 16:10:41 INFO - PROCESS | 15064 | _x_x_mozilla_page_load_details 16:10:41 INFO - PROCESS | 15064 | |i|pagename|runs| 16:10:41 INFO - PROCESS | 15064 | |0;ai-astar;105;115;114;114;112;113;118;114;114;114 16:10:41 INFO - PROCESS | 15064 | |1;audio-beat-detection;152;123;126;196;126;126;153;126;183;131 16:10:41 INFO - PROCESS | 15064 | |2;audio-dft;161;162;162;163;160;161;160;162;161;160 16:10:41 INFO - PROCESS | 15064 | |3;audio-fft;75;76;77;119;76;78;78;77;106;76 16:10:41 INFO - PROCESS | 15064 | |4;audio-oscillator;87;85;112;86;85;85;130;86;85;125 16:10:41 INFO - PROCESS | 15064 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 16:10:41 INFO - PROCESS | 15064 | |6;imaging-darkroom;146;146;146;146;147;145;146;146;146;146 16:10:41 INFO - PROCESS | 15064 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 16:10:41 INFO - PROCESS | 15064 | |8;json-parse-financial;63;61;61;61;67;61;60;62;63;60 16:10:41 INFO - PROCESS | 15064 | |9;json-stringify-tinderbox;65;66;65;65;67;66;65;65;65;65 16:10:41 INFO - PROCESS | 15064 | |10;stanford-crypto-aes;85;79;78;79;80;80;79;80;79;88 16:10:41 INFO - PROCESS | 15064 | |11;stanford-crypto-ccm;134;132;129;131;132;131;133;130;177;131 16:10:41 INFO - PROCESS | 15064 | |12;stanford-crypto-pbkdf2;162;164;161;161;162;160;164;167;166;163 16:10:41 INFO - PROCESS | 15064 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;67;65;66;65;67 16:10:41 INFO - PROCESS | 15064 | __end_tp_report 16:10:41 INFO - PROCESS | 15064 | __start_cc_report 16:10:41 INFO - PROCESS | 15064 | _x_x_mozilla_cycle_collect,1946 16:10:41 INFO - PROCESS | 15064 | __end_cc_report 16:10:41 INFO - PROCESS | 15064 | __startTimestamp1469229041717__endTimestamp 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | ------- Summary: start ------- 16:10:41 INFO - PROCESS | 15064 | Number of tests: 14 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:1.64 16:10:41 INFO - PROCESS | 15064 | Values: 105.0 115.0 114.0 114.0 112.0 113.0 118.0 114.0 114.0 114.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:141.50 stddev:26.41 (18.7%) stddev-sans-first:27.86 16:10:41 INFO - PROCESS | 15064 | Values: 152.0 123.0 126.0 196.0 126.0 126.0 153.0 126.0 183.0 131.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 16:10:41 INFO - PROCESS | 15064 | Values: 161.0 162.0 162.0 163.0 160.0 161.0 160.0 162.0 161.0 160.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.50 stddev:15.46 (20.2%) stddev-sans-first:16.07 16:10:41 INFO - PROCESS | 15064 | Values: 75.0 76.0 77.0 119.0 76.0 78.0 78.0 77.0 106.0 76.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:18.30 (21.5%) stddev-sans-first:19.08 16:10:41 INFO - PROCESS | 15064 | Values: 87.0 85.0 112.0 86.0 85.0 85.0 130.0 86.0 85.0 125.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:10:41 INFO - PROCESS | 15064 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 16:10:41 INFO - PROCESS | 15064 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 146.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:10:41 INFO - PROCESS | 15064 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.50 stddev:2.08 (3.4%) stddev-sans-first:2.17 16:10:41 INFO - PROCESS | 15064 | Values: 63.0 61.0 61.0 61.0 67.0 61.0 60.0 62.0 63.0 60.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 16:10:41 INFO - PROCESS | 15064 | Values: 65.0 66.0 65.0 65.0 67.0 66.0 65.0 65.0 65.0 65.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.20 (4.0%) stddev-sans-first:2.99 16:10:41 INFO - PROCESS | 15064 | Values: 85.0 79.0 78.0 79.0 80.0 80.0 79.0 80.0 79.0 88.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.00 stddev:14.48 (11.0%) stddev-sans-first:15.34 16:10:41 INFO - PROCESS | 15064 | Values: 134.0 132.0 129.0 131.0 132.0 131.0 133.0 130.0 177.0 131.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.37 16:10:41 INFO - PROCESS | 15064 | Values: 162.0 164.0 161.0 161.0 162.0 160.0 164.0 167.0 166.0 163.0 16:10:41 INFO - PROCESS | 15064 | 16:10:41 INFO - PROCESS | 15064 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 16:10:41 INFO - PROCESS | 15064 | Values: 67.0 67.0 67.0 66.0 68.0 67.0 65.0 66.0 65.0 67.0 16:10:41 INFO - PROCESS | 15064 | -------- Summary: end -------- 16:10:41 INFO - PROCESS | 15064 | 16:10:42 INFO - TEST-INFO | 15064: exit 0 16:10:42 INFO - TEST-OK | kraken | took 63585ms 16:10:42 INFO - SUITE-END | took 1183s 16:10:43 INFO - Completed test suite (00:19:43) 16:10:43 INFO - javascript benchmark 16:10:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.2879458149005, 2604.3879688273264, 2629.8290611110283, 2637.7889768818495, 2643.907463238786, 4630.166570017395, 4707.270373092168, 4829.589484893784, 4837.951620483794, 4890.633202509813, 4734.857954261369, 4740.241561350184, 4745.952540474595, 4782.497837727041, 4848.927266091003, 4363.38912552243, 4426.690131690783, 4439.8446054388105, 4464.084862603175, 4493.2136876046725, 4359.651227901776, 4463.73217606943, 4480.081583275437, 4497.25795243786, 4542.386777785006, 4496.280595104784, 4520.886977825564, 4524.502304746476, 4531.410916580857, 4537.160625284333, 4320.071184695305, 4343.4787825460835, 4376.0591472833175, 4404.075144219718, 4444.155610434007, 4359.869203923888, 4363.694541382105, 4367.192069467159, 4376.343548467724, 4417.712848664826, 4829.855104346875, 4841.951580484185, 4854.927176092326, 4881.316615673809, 4889.07107649549, 4995.950040499585, 5008.398992120932, 5127.384713834326, 5141.2288156776785, 5195.0, 5012.573931215851, 5033.84898453047, 5073.949260507421, 5080.542751152377, 5128.0, 4732.692374995614, 4733.5266473352385, 4740.170470167707, 4763.2140696784645, 4768.213244814636, 5091.974540127276, 5182.97408512955, 5200.0, 5287.127623942083, 5287.4448182941005, 5076.340075790124, 5091.592672586185, 5096.847094587169, 5098.2352647103235, 5106.719130447861, 5126.641135120581, 5138.075146473596, 5142.97428512855, 5184.714840683799, 5195.350581177353, 4898.90202195954, 5004.47453017428, 5060.1903695408555, 5071.644984851099, 5103.438621751604, 5096.464871188546, 5151.845444636667, 5165.096108181053, 5165.690058596496, 5168.483151684876, 4362.672799540047, 4371.038371558252, 4371.803268852909, 4373.825046998148, 4414.381986521889, 3719.423489359154, 3800.8859734208017, 3853.9614603854166, 3857.787821669835, 3859.96140038596, 4272.636825869836, 4310.913781724411, 4369.300911854088, 4375.059362237134, 4422.624076953431, 5130.897382052338, 5132.127538318495, 5139.049275883974, 5139.897202055938, 5189.792408303701, 4327.415798867176, 4365.519792822787, 4367.650587952956, 4369.475662920407, 4406.823727050882, 4476.910461790746, 4517.164324599894, 4551.294549344857, 4565.497795242521, 4615.076984603093, 4693.5071817458675, 4724.811007559659, 4725.527447255385, 4731.408573928259, 4774.427068751772, 5045.2936588876855, 5073.213651883964, 5081.898362032664, 5100.362454693163, 5150.0987327216835, 4641.419822522184, 4703.788329525248, 4729.739864307358, 4760.476347601831, 4829.396325459317, 5019.272205530251, 5053.7473126344275, 5059.392872855281, 5062.721550314768, 5104.336436263262, 5085.4914508548845, 5127.4872512748425, 5127.79488820443, 5128.9487105129965, 5131.820386286462, 4793.400824896888, 4911.066897289504, 4972.055309491185, 4999.325091112653, 5051.722155281494, 4950.2079667253065, 4953.356063711694, 4961.925571116509, 4969.726665033313, 5012.749362531932, 4900.558949694545, 4902.730349830794, 4932.7286999215385, 4949.307097006494, 4952.281919121635, 4858.805647774049, 4926.630502712239, 4953.430355509163, 4977.950220497749, 5018.84943451697, 4875.43932447773, 4883.804647814048, 4886.267059941038, 4890.336547334561, 4936.407631084293], "value": 4688.4717627279715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3177095325107, 588.4262843727365, 589.0810335876031, 601.8916595012897, 604.7973928733874, 27886.44227115459, 40956.38565421521, 41535.99999999996, 41692.37461438081, 41727.582724172746, 42434.78782606091, 42784.572154278445, 42863.35704964428, 42874.35688464668, 42966.7851660742, 7446.627668616575, 7521.661525231364, 7652.7704168875025, 7655.2344765523285, 7665.770026899174, 7450.664720087609, 7657.234276572354, 7718.459707820455, 7721.150673425918, 9812.656557020506, 9850.605975760996, 10186.28695991281, 10188.184945204403, 10197.388156710584, 10200.285979981405, 10029.899701003005, 10081.344712593658, 10093.0, 10097.495125243746, 10119.342242754197, 9938.652147174815, 9951.5024248788, 9992.200623950066, 10003.699889003268, 10009.59961601535, 38310.23379532422, 38504.0, 38566.807165964274, 38635.0, 38712.225755485015, 2964.3626620276527, 3348.0, 3361.344537815127, 3371.089805752458, 3475.1833319169973, 29793.404131917458, 29981.55027674565, 30067.248318791986, 30207.09378718642, 31315.843420782978, 3295.884644037471, 3314.386838434897, 3338.315645292709, 3444.4144495435835, 3469.2020835208045, 252668.0, 253745.0, 255606.0, 255609.0, 255993.7200314005, 33585.664143358255, 54125.45874541283, 54399.728001360534, 54525.1821222682, 54538.45461545413, 34137.0, 34311.142221444665, 34368.0, 34393.140171495914, 34411.4838277426, 12664.303463309423, 12692.746145077232, 12693.365331733376, 12694.365281735876, 12701.36493175356, 11814.822777658343, 11899.762004759856, 11931.0, 11938.52245910154, 11941.820872686916, 7391.186969433358, 7699.11460182075, 7930.365570754326, 7952.204779522117, 8057.6374063167295, 3080.922976925595, 3084.383123375334, 3094.5512900629283, 3106.6116735408073, 3140.262038420969, 773.7485317271909, 774.8721460958991, 885.3758100539104, 996.1283876607968, 1014.9289549731595, 27879.442411152068, 28193.43613127726, 28564.857175713987, 28641.713582864322, 28843.56734648982, 931.2689538712078, 934.5374039850318, 945.1682519382899, 946.1329048957894, 959.9808003839884, 14875.47935822241, 15041.849581504264, 15082.396704131932, 15087.54737357859, 15297.0, 411011.0, 414516.0, 416400.0, 416580.0, 416638.0, 48923.510764892606, 49279.0, 49341.75329123331, 49483.25775113376, 49507.50492495029, 1082.1505118482112, 1152.7982603044434, 1167.754771497978, 1189.2210602055668, 1228.2139430764319, 28414.147575572766, 29355.41289174162, 29849.5522567166, 29880.551791722708, 30438.23904402319, 43724.0, 44514.0, 44626.330605040304, 44627.0, 44636.77681611701, 321147.0, 324442.0, 324724.0, 324933.0, 325869.3706531452, 26290.342741430853, 27340.179794606192, 27342.316442089108, 27589.172324830288, 27672.584911225946, 42309.1538169241, 42659.57340426556, 43036.0, 43092.0, 43538.56461435472, 36555.45166822553, 36610.45084323684, 37096.443553347264, 37739.0, 37828.0, 36578.26843463169, 37348.439773402875, 37350.81324593468, 37888.0, 38996.0, 36051.278974420886, 36737.448938265414, 37002.62997369992, 37198.814005929795, 37494.250114998096, 31253.0, 33520.49719254262, 33968.490472643425, 34006.0, 34042.14894627654, 25550.744492554837, 25624.359391014626, 25652.0, 26063.73936260689, 26320.0], "value": 17098.095133939896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8063484448707, 370.10619354259467, 370.4572800846759, 379.8233821273108, 384.3235904807538, 12312.507499700012, 16063.437779677713, 16605.501834944942, 17934.820651793478, 18023.279068837262, 15147.166905820175, 15261.77107343388, 17643.47069587911, 17776.11119444029, 17798.19908104135, 4958.454569997298, 4979.327790748239, 5117.0, 5155.381354237496, 5157.5358217760395, 3795.867144649938, 5056.3173971513925, 5138.177891537355, 5742.569307301969, 6087.573869829113, 6108.725107370156, 6119.5410344224365, 6120.1125836753645, 6126.23422072241, 6128.080787881809, 6002.939970600325, 6067.635941843503, 6071.848203794918, 6115.510759139258, 6169.5064394848305, 5207.4792520748, 5387.380451248078, 5396.460353964611, 5399.78400863965, 5400.324959380077, 21331.68002479964, 21432.785672143236, 21485.355439336843, 21575.67636485454, 21670.0, 1808.439383791029, 1876.5590086329837, 1878.1736036144052, 1918.6258679557493, 2409.024345140221, 12407.75184496305, 13085.86914130856, 13461.865381346257, 13551.728965420734, 13554.864451355557, 1702.3190723710616, 1714.2714346402854, 1782.9926091758116, 1797.0655259265109, 1816.9636607267912, 67896.3210367895, 70608.6469567654, 72254.63872680656, 72799.0, 73019.0, 9667.323287369958, 9782.804343913223, 9902.455364954852, 9969.0, 10040.548175331982, 13285.73428531424, 13301.73396532064, 13391.397387117602, 13417.194968301737, 13442.731145377038, 7458.4033277337685, 7515.924840751632, 7704.152543220242, 7812.882806757903, 7863.405076324799, 7520.135184453858, 7536.237655304268, 7653.15815260321, 7790.454668173174, 7798.064232292048, 6191.566590338633, 6210.223722034746, 6282.968585157045, 6302.464290535264, 6394.0408938659575, 1749.6413235286736, 1755.1399814091003, 1784.3397942761262, 1787.8212178782019, 1822.3166312632763, 830.0537387378394, 895.5696515689797, 896.5069211933411, 991.6231831903974, 992.1814503035025, 17079.743803842954, 17379.47861564155, 18108.185131669106, 18109.818901811075, 18274.908625457054, 865.8441480533564, 888.8089060851947, 891.9420237684529, 902.0888902208685, 929.4934260827865, 9779.706608801747, 9933.950330248446, 10329.84505232422, 10368.170546356274, 10400.29966287926, 391611.0, 391863.0, 392920.0, 395169.0, 395568.0, 42799.572004280184, 59785.10322345168, 70154.0, 72674.2732572678, 73042.0, 882.6778225947482, 906.1346414174448, 958.769895225141, 971.955148215671, 982.2583949118513, 15463.5360939172, 15553.76669349938, 15766.842331576996, 16038.759418608497, 16062.598435039217, 36344.84101816306, 36747.81626091959, 37329.25341493101, 37590.248195036496, 37947.24105517929, 47397.52602473931, 47642.761786190844, 47769.52230477651, 47824.0, 48270.75864620795, 7089.858202836018, 7225.0, 7240.637968101469, 7253.963730181315, 7699.461037727306, 11571.537138514364, 12463.875361246271, 12532.561360352343, 12575.748485030432, 12924.224546527239, 10021.0, 10241.795164096826, 10492.213084018882, 10571.2600117991, 10696.946515267375, 10576.788464230825, 10813.080888124283, 10936.56253749841, 11019.0, 11035.72410689707, 10104.69685909424, 10263.58945642166, 10354.17166626653, 10593.258471906893, 10699.465026748787, 7204.027456293543, 7297.306755858185, 7435.4795164337975, 7484.588347640932, 7623.199564045917, 9783.9021609783, 9834.0, 10104.393736375841, 10276.22928280397, 10726.463676815973], "value": 8471.432490083027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.4694351843984, 1350.1156742333771, 1421.0336970859814, 1446.6383404148962, 1708.1630001299368, 6679.833004174892, 7483.9251607483975, 7712.0745510538745, 7772.766816995485, 8024.11734709183, 7796.103448103469, 7856.214378562141, 7867.0559532856, 7868.4098692598145, 7871.094824095231, 2198.505336299328, 2230.9180047676946, 2234.028197733983, 2235.9552808943813, 2236.463248820288, 2145.2491627930176, 2170.739511258651, 2214.3356992902145, 2217.2683014605223, 2219.9223027194053, 2171.0447403142643, 2171.543975765091, 2178.9564208715815, 2183.3122566391617, 2215.7341119065736, 2158.9136434542756, 2165.783421657837, 2169.5552411755552, 2171.0772921508296, 2173.815225705817, 2123.3417640531484, 2163.610550100981, 2164.6103701333755, 2168.6638571021517, 2169.6962425260476, 7844.37245020397, 7862.882056769153, 7902.130765615778, 7912.762617121495, 7951.324137448324, 4471.217536931024, 4607.631389488833, 4635.930461043054, 4697.812087516495, 4703.129920964632, 2839.5030869597736, 2924.225080353708, 2945.779066570016, 2948.115565330392, 2956.2609347663083, 959.7936443664576, 968.3028219681818, 969.5055521683992, 984.2667212926344, 987.5407935310044, 10706.518206680717, 10760.892391076068, 10805.675829725122, 10855.294405863593, 10858.891411085868, 4080.7959602019782, 4221.02916329246, 4313.762743049162, 4480.215962206601, 4481.932771008437, 8459.746207613782, 8617.482951022834, 8628.956855215809, 8630.180132887366, 8633.179847914438, 4779.187538118528, 4781.11549363362, 4781.139394908881, 4781.497942715965, 4782.450018247877, 3628.292482965849, 3740.8690695825517, 4167.874673838047, 4417.359482875029, 4428.31361139024, 3430.091025878144, 3447.775894566845, 3558.057114864563, 3575.1955809942556, 3579.284143171376, 1048.2452634103433, 1069.6951368859839, 1082.0856376361962, 1086.9130469562417, 1090.6346373964811, 866.3372520022189, 889.2530274569393, 892.3307519360479, 894.9060348663427, 927.4435338796668, 5242.16125419931, 5347.41178470368, 5375.086235340002, 5475.123980163235, 5504.174373843955, 405.6146660672314, 406.6705968165795, 411.1940596431029, 419.73976134796624, 425.78072292768627, 3699.2601479704167, 3703.4629978652943, 3720.4419337099653, 3823.636754508317, 3897.006263402814, 9566.0, 9855.950720246496, 9948.054934781185, 9948.253880958813, 9952.601895924226, 9864.901350986398, 9870.457124858058, 9876.111149996535, 9876.703698889045, 9890.159336456481, 7307.707691692272, 7443.590602516805, 7446.143693475211, 7557.2820582044615, 7569.621518924032, 5477.287952566141, 5484.369297530835, 5497.587680923867, 5528.391876893619, 5727.914081288701, 9067.183953444222, 9137.177654011171, 9158.40470369424, 9168.633254669738, 9205.76985575366, 8046.9538959934835, 8526.232639062515, 8541.914580854113, 8935.642574296955, 8962.058983806606, 6509.7396104155305, 6619.900701489385, 6751.662416879235, 6793.762218322335, 6794.3545363190415, 7191.532550384418, 7210.351068403869, 7218.169910460364, 7274.454415918933, 7293.9635301823155, 6885.586864788129, 6934.479914006369, 6957.652117394009, 6958.582485050913, 6964.4080253179045, 6692.464602831665, 6766.323367663194, 6796.2524122347495, 6805.3875151236625, 6838.281980391987, 6256.843578910563, 6305.90541141874, 6334.3665633436285, 6347.5556711029785, 6347.936520634919, 4573.931391029204, 4757.26262429324, 4758.1911075118005, 4784.258439941815, 4789.425268967746, 4615.030843522898, 4645.256758918556, 4713.7643117844655, 4779.115863565252, 4845.49122342149], "value": 4084.70396201303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.24600530630977, 297.3280386326901, 300.7999680212659, 300.97291243788084, 303.4250096067951, 4811.374521312229, 4862.246351815475, 4865.902681946363, 4866.732329721873, 4867.926981095277, 4545.181867263891, 4640.7215567066, 4683.76581170941, 4761.69049011814, 4813.157697402958, 3811.752236104658, 3818.8854334369876, 3828.3300422426105, 3829.6936245100464, 3833.195029043904, 3812.809359532026, 3822.0253835271965, 3826.8086595670243, 3827.913786986085, 3842.634949679776, 3601.873934412296, 3662.6154253803365, 3758.49260349852, 3786.129190286236, 3790.639889210521, 3771.849126034955, 3780.1305699689087, 3780.5652349979828, 3782.130110074698, 3804.7907365094907, 3345.3476572068457, 3363.4786608075788, 3367.6295607483157, 3368.528406023159, 3370.898873033813, 4472.306792447176, 4702.365180700596, 4716.985848042653, 4733.881652958669, 4734.313524538922, 4235.618794308496, 4251.59609837065, 4255.425517555122, 4260.062786187033, 4273.273543497613, 5021.372328458942, 5025.748712564357, 5026.648134630577, 5040.117979353635, 5048.924266136011, 3569.303985722785, 3569.660882216185, 3594.370985077601, 3597.4963505109304, 3598.442241452579, 4989.975050124726, 5183.896322073575, 5230.764615592308, 5233.717739153932, 5245.344331958467, 3767.1712223311374, 3779.225258821935, 3785.5835858055593, 3787.5265591801026, 3793.734438589272, 3845.673117784964, 3858.2090671412293, 3861.942070868939, 3867.671247943956, 3872.4191371294532, 4111.157212771374, 4316.870493885189, 4334.371516130206, 4339.891502712458, 4346.587359108303, 4986.775595098156, 5007.949920500749, 5020.7740651670765, 5021.84934451967, 5024.171011783088, 1251.8059700746217, 1295.7084655952524, 1314.3559655768795, 1315.329182117108, 1320.7094439223356, 864.4035615425462, 907.7367563406671, 937.5640327247862, 938.2634631813993, 941.0332405273012, 4402.669799764966, 4403.889902752393, 4406.942333839856, 4414.536473670282, 4425.513193548707, 5130.692158470503, 5140.871478213075, 5156.1492353761205, 5166.844994650167, 5167.250748641502, 4300.569943005675, 4375.234333991539, 4391.077873646506, 4403.207422663952, 4410.911781764346, 2722.224166112688, 2724.264448598867, 2735.083746944756, 2741.3557813913712, 2742.149933520615, 4771.926316578742, 4772.928406073912, 4776.904461910743, 4789.377380940525, 4797.208460603962, 5024.698518088853, 5186.481351864859, 5217.426083130853, 5246.291750613695, 5257.894842103136, 4693.131770622445, 4748.430188377417, 4751.976240118777, 4759.286107083896, 4761.500042495488, 5062.82280120194, 5094.1849304111165, 5105.617078719185, 5136.383633963948, 5146.511081447256, 4835.178019736723, 4967.379077615298, 5085.4914508548845, 5092.796288148581, 5129.563987061141, 4840.419149702058, 4845.466998630219, 4855.955969466581, 4863.294822250825, 4867.294242334912, 3653.5433070866143, 3656.689181419503, 3664.8350824213508, 3674.5774235962135, 3681.4293784463453, 5096.923546146885, 5182.274481572658, 5191.676122588716, 5194.68831870089, 5242.213667949838, 5035.823746168867, 5038.647294689336, 5068.023470846447, 5071.4421413645205, 5076.949230507647, 5042.84871453857, 5043.672161309503, 5059.0, 5072.644914855925, 5074.441811400817, 4761.452432970253, 4813.807447702053, 4946.332245147003, 5002.949970500248, 5018.774155162953, 4924.926126108039, 5096.23556466533, 5097.9294348187295, 5103.004914041726, 5110.8466745997675, 4956.281339205867, 4984.501549844987, 4987.700737955734, 4992.151334273255, 4997.400311962588], "value": 3806.1024993918572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4780816785313, 606.8634557224623, 633.8890694128527, 670.2928410526895, 707.738136889351, 12637.494500219991, 13217.603471895847, 13218.669533261673, 13218.801717974238, 13246.205227686345, 12579.433925473353, 12664.683382915431, 12669.0, 12679.556215532459, 12691.61925142245, 628.2868943748855, 753.081240886118, 762.1045271805621, 769.7459838253363, 780.9765707028798, 769.6575024114271, 778.9922100778977, 779.4154384211841, 779.575131553302, 779.5946108023825, 834.2575108153748, 839.3620848155415, 841.2176675691604, 842.8904242448504, 843.1526316052359, 660.7489154121452, 797.0952968380872, 828.349745449819, 834.2825170353491, 834.4742812028413, 610.700756629253, 610.8503416662902, 611.1108337369117, 611.1657587393221, 611.1932249430753, 12444.75110497794, 12522.874771252262, 12528.624141275777, 12545.74908501825, 12560.560380386734, 12218.389080545938, 12430.254184748945, 12516.435445569305, 13020.414081366267, 13061.0, 11199.824018478106, 11235.66293011211, 11281.210315277935, 11289.661310160709, 11715.707107322385, 4061.97969010156, 4073.348264277701, 4076.449679293317, 4089.8364065437645, 4220.155968806251, 61037.0, 61853.0, 62158.37841621571, 62255.6887215561, 62583.687081565215, 10161.339512931636, 10246.180305575535, 10260.076593106656, 10267.0759631632, 10390.688279351632, 19143.712844307345, 19184.424467266006, 19204.903975480032, 19216.0, 19221.519462013563, 6607.603543787388, 6632.0, 6831.658417079127, 6848.14398200225, 7028.613426261605, 3625.4743062255825, 3669.7064234861145, 3683.3369993401443, 3701.8704345348324, 3736.2637362637256, 2761.8757155928033, 2870.6124673169275, 2873.741363277315, 2882.567614857788, 2883.1062370665163, 547.1273319056099, 560.7897038610521, 561.0994354061754, 567.2059117235902, 581.7905554000556, 578.3522454850511, 607.2530787131852, 612.2713970375239, 618.4094190048493, 622.6699849079995, 7968.442209045427, 8193.139720329398, 8230.42387032902, 8293.751187464386, 8383.371247156487, 496.39439883342266, 547.3814589513823, 592.4934181274948, 594.402625361509, 600.2886579403333, 3768.1521657626813, 3957.980210098931, 3979.5821438749094, 3984.382420724792, 4095.2014357200655, 89643.0, 100458.0, 105216.47391762992, 106107.0, 110135.44932275287, 93787.0, 93932.53033734788, 95190.52404737932, 95405.5229723847, 96384.51807740917, 77894.22105778984, 78007.0, 78502.0, 82189.58905205555, 82509.58745206236, 6322.810315690536, 7442.813929651802, 7588.582627955516, 7648.694052237848, 8014.9355259954655, 43577.346339804295, 44213.33679994867, 45040.77479612581, 45852.31221531613, 46604.06791864076, 64941.675291623236, 66556.66721666361, 66992.29100216941, 67542.3245767536, 68173.65913170403, 8042.396820238622, 8245.257926786619, 8447.281981031681, 8503.0221524523, 8537.658493660185, 10689.625863095065, 10774.353538787698, 10884.836727448936, 11963.282203067844, 12268.754624907631, 7377.631118444164, 9859.852102218329, 9960.252981026597, 10369.481525923522, 11707.239029463057, 11151.83272250933, 11224.214304998899, 11340.489677964677, 11455.484503197542, 12159.392030398622, 11476.13928955315, 11553.364564949008, 11569.479373428385, 11597.76804463923, 12018.879811201776, 10087.546060427445, 10197.847032294374, 10417.427041512487, 10535.841962370723, 10631.840522392016, 10065.849012264676, 10300.381977081099, 10307.845382319421, 10453.843192352273, 10487.475626218811], "value": 6544.093523735548, "unit": "score"}], "name": "dromaeo_css", "value": 6405.887262873116, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 112.0, 113.0, 118.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 126.0, 196.0, 126.0, 126.0, 153.0, 126.0, 183.0, 131.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 119.0, 76.0, 78.0, 78.0, 77.0, 106.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 112.0, 86.0, 85.0, 85.0, 130.0, 86.0, 85.0, 125.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 67.0, 61.0, 60.0, 62.0, 63.0, 60.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 78.0, 79.0, 80.0, 80.0, 79.0, 80.0, 79.0, 88.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 129.0, 131.0, 132.0, 131.0, 133.0, 130.0, 177.0, 131.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 161.0, 162.0, 160.0, 164.0, 167.0, 166.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 65.0, 66.0, 65.0, 67.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1530.6000000000001, "alertThreshold": 2.0}]} 16:10:43 INFO - Return code: 0 16:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:43 INFO - # TBPL SUCCESS # 16:10:43 INFO - Running post-action listener: _resource_record_post_action 16:10:43 INFO - [mozharness: 2016-07-22 23:10:43.498885Z] Finished run-tests step (success) 16:10:43 INFO - Running post-run listener: _resource_record_post_run 16:10:43 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536227840; Read time: 12; Write time: 367088 16:10:43 INFO - TinderboxPrint: CPU usage
13.0% 16:10:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:10:43 INFO - TinderboxPrint: I/O write bytes / time
536,227,840 / 367,088 16:10:43 INFO - TinderboxPrint: CPU idle
8,334.8 (87.0%) 16:10:43 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 16:10:43 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247144448; Read time: 0; Write time: 203152 16:10:43 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289083392; Read time: 0; Write time: 163936 16:10:44 INFO - Running post-run listener: _upload_blobber_files 16:10:44 INFO - Blob upload gear active. 16:10:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:44 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 16:10:44 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:10:44 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:05 INFO - (blobuploader) - INFO - Done attempting. 16:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:06 INFO - (blobuploader) - INFO - Done attempting. 16:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:07 INFO - (blobuploader) - INFO - Done attempting. 16:11:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:07 INFO - Return code: 0 16:11:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ea63b35ab6fb43370fa381f83feddc8dce2d3f57a2634864376ec4168a8506b0408cb2b230a0a2356008389d4841514898cb12a4321dccc7ca0458afb70bf583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03ba92b6cfeae167e6e1944b8a021e6c54446a878584412864493ff346faa49a8110b4d9f49e3c60e8cb957078138be05c2a7068689a8b817b35d97198cc43f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a93e63f8963a1ee40b996ced718718fa4d34dbbea59ea4c850aba05c9b62102f88f3e555290ef35cae169ad9c96631b931fba2a08eb89d2fcf41be3a76fede8d"} 16:11:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:07 INFO - Contents: 16:11:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ea63b35ab6fb43370fa381f83feddc8dce2d3f57a2634864376ec4168a8506b0408cb2b230a0a2356008389d4841514898cb12a4321dccc7ca0458afb70bf583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03ba92b6cfeae167e6e1944b8a021e6c54446a878584412864493ff346faa49a8110b4d9f49e3c60e8cb957078138be05c2a7068689a8b817b35d97198cc43f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a93e63f8963a1ee40b996ced718718fa4d34dbbea59ea4c850aba05c9b62102f88f3e555290ef35cae169ad9c96631b931fba2a08eb89d2fcf41be3a76fede8d"} 16:11:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:07 INFO - Copying logs to upload dir... 16:11:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.272355 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-22 16:11:07.360691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 16:11:07.364936) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ea63b35ab6fb43370fa381f83feddc8dce2d3f57a2634864376ec4168a8506b0408cb2b230a0a2356008389d4841514898cb12a4321dccc7ca0458afb70bf583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03ba92b6cfeae167e6e1944b8a021e6c54446a878584412864493ff346faa49a8110b4d9f49e3c60e8cb957078138be05c2a7068689a8b817b35d97198cc43f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a93e63f8963a1ee40b996ced718718fa4d34dbbea59ea4c850aba05c9b62102f88f3e555290ef35cae169ad9c96631b931fba2a08eb89d2fcf41be3a76fede8d"} build_url:https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/Z2INfo7-QCu-hr3UQ-7Kag/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/Autoland-Non-PGO/sha512/ea63b35ab6fb43370fa381f83feddc8dce2d3f57a2634864376ec4168a8506b0408cb2b230a0a2356008389d4841514898cb12a4321dccc7ca0458afb70bf583", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03ba92b6cfeae167e6e1944b8a021e6c54446a878584412864493ff346faa49a8110b4d9f49e3c60e8cb957078138be05c2a7068689a8b817b35d97198cc43f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a93e63f8963a1ee40b996ced718718fa4d34dbbea59ea4c850aba05c9b62102f88f3e555290ef35cae169ad9c96631b931fba2a08eb89d2fcf41be3a76fede8d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 16:11:07.390250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 16:11:07.390590) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469227058.324870-1709608151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 16:11:07.473242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 16:11:07.473564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 16:11:07.473856) ========= ========= Total master_lag: 0.17 =========