builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1469650081.08 results: success (0) buildid: 20160727114841 builduid: 88dfd59033a54cceac42de3ec16f5983 revision: ca76fbe8cb78f894b835dee6cdb2bced219af56c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:01.081167) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:01.082136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:01.082450) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:01.742996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:01.743459) ========= 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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 13:08:01-- 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% 227M=0s 2016-07-27 13:08:02 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174979 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.035494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.035983) ========= 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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.123354 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.181479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.182002) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ca76fbe8cb78f894b835dee6cdb2bced219af56c --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 ca76fbe8cb78f894b835dee6cdb2bced219af56c --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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 13:08:02,405 truncating revision to first 12 chars 2016-07-27 13:08:02,405 Setting DEBUG logging. 2016-07-27 13:08:02,405 attempt 1/10 2016-07-27 13:08:02,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ca76fbe8cb78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 13:08:02,708 unpacking tar archive at: autoland-ca76fbe8cb78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640572 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.935948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.936618) ========= script_repo_revision: ca76fbe8cb78f894b835dee6cdb2bced219af56c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.937394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:02.937877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 13:08:03.089905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-07-27 13:08:03.090752) ========= /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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:08:03 INFO - MultiFileLogger online at 20160727 13:08:03 in /builds/slave/test 13:08:03 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 13:08:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:03 INFO - {'append_to_log': False, 13:08:03 INFO - 'base_work_dir': '/builds/slave/test', 13:08:03 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:08:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:03 INFO - 'branch': 'Autoland-Non-PGO', 13:08:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:03 INFO - 'config_files': ('talos/linux_config.py',), 13:08:03 INFO - 'default_actions': ('clobber', 13:08:03 INFO - 'read-buildbot-config', 13:08:03 INFO - 'download-and-extract', 13:08:03 INFO - 'populate-webroot', 13:08:03 INFO - 'create-virtualenv', 13:08:03 INFO - 'install', 13:08:03 INFO - 'run-tests'), 13:08:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:03 INFO - 'download_minidump_stackwalk': True, 13:08:03 INFO - 'download_symbols': 'ondemand', 13:08:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:03 INFO - 'installer_path': 'installer.exe', 13:08:03 INFO - 'log_level': 'info', 13:08:03 INFO - 'log_name': 'talos', 13:08:03 INFO - 'log_to_console': True, 13:08:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:08:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:08:03 INFO - 'opt_config_files': (), 13:08:03 INFO - 'pip_index': False, 13:08:03 INFO - 'sps_profile': False, 13:08:03 INFO - 'sps_profile_interval': 0, 13:08:03 INFO - 'suite': 'dromaeojs', 13:08:03 INFO - 'system_bits': '32', 13:08:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:03 INFO - 'title': 'talos-linux64-ix-032', 13:08:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:03 INFO - 'use_talos_json': True, 13:08:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:03 INFO - 'work_dir': 'build'} 13:08:03 INFO - [mozharness: 2016-07-27 20:08:03.510142Z] Running clobber step. 13:08:03 INFO - Running pre-action listener: _resource_record_pre_action 13:08:03 INFO - Running main action method: clobber 13:08:03 INFO - rmtree: /builds/slave/test/build 13:08:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:05 INFO - Running post-action listener: _resource_record_post_action 13:08:05 INFO - [mozharness: 2016-07-27 20:08:05.252600Z] Finished clobber step (success) 13:08:05 INFO - [mozharness: 2016-07-27 20:08:05.252700Z] Running read-buildbot-config step. 13:08:05 INFO - Running pre-action listener: _resource_record_pre_action 13:08:05 INFO - Running main action method: read_buildbot_config 13:08:05 INFO - Using buildbot properties: 13:08:05 INFO - { 13:08:05 INFO - "project": "", 13:08:05 INFO - "product": "firefox", 13:08:05 INFO - "script_repo_revision": "production", 13:08:05 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:08:05 INFO - "repository": "", 13:08:05 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:08:05 INFO - "buildid": "20160727114841", 13:08:05 INFO - "pgo_build": "False", 13:08:05 INFO - "basedir": "/builds/slave/test", 13:08:05 INFO - "buildnumber": 134, 13:08:05 INFO - "slavename": "talos-linux64-ix-032", 13:08:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:08:05 INFO - "platform": "ubuntu64_hw", 13:08:05 INFO - "scheduler": "tests-autoland-linux64-talos", 13:08:05 INFO - "branch": "autoland", 13:08:05 INFO - "repo_path": "integration/autoland", 13:08:05 INFO - "revision": "ca76fbe8cb78f894b835dee6cdb2bced219af56c", 13:08:05 INFO - "stage_platform": "linux64", 13:08:05 INFO - "builduid": "88dfd59033a54cceac42de3ec16f5983", 13:08:05 INFO - "slavebuilddir": "test" 13:08:05 INFO - } 13:08:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:08:05 INFO - Running post-action listener: _resource_record_post_action 13:08:05 INFO - [mozharness: 2016-07-27 20:08:05.255119Z] Finished read-buildbot-config step (success) 13:08:05 INFO - [mozharness: 2016-07-27 20:08:05.255209Z] Running download-and-extract step. 13:08:05 INFO - Running pre-action listener: _resource_record_pre_action 13:08:05 INFO - Running main action method: download_and_extract 13:08:05 INFO - mkdir: /builds/slave/test/build/tests 13:08:05 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')]} 13:08:05 INFO - https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:14 INFO - Downloaded 1361 bytes. 13:08:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:14 INFO - Using the following test package requirements: 13:08:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:08:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:08:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'jsshell-linux-x86_64.zip'], 13:08:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:08:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:08:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:08:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:08:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:08:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:08:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:08:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:08:14 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')]} 13:08:14 INFO - https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:18 INFO - Downloaded 22746774 bytes. 13:08:18 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'] 13:08:18 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 13:08:20 INFO - Return code: 0 13:08:20 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 13:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:20 INFO - https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:21 INFO - Downloaded 22746774 bytes. 13:08:21 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'] 13:08:21 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 13:08:25 INFO - Return code: 0 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:25 INFO - https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:08:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:30 INFO - Downloaded 14413725 bytes. 13:08:30 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'] 13:08:30 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 13:08:30 INFO - Return code: 0 13:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:30 INFO - https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UZyw8R1LS7aJirxKkzrUng/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 13:08:31 INFO - Downloaded 57160078 bytes. 13:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:31 INFO - mkdir: /builds/slave/test/properties 13:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:31 INFO - Contents: 13:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:08:32 INFO - Running post-action listener: _resource_record_post_action 13:08:32 INFO - Running post-action listener: set_extra_try_arguments 13:08:32 INFO - [mozharness: 2016-07-27 20:08:32.267026Z] Finished download-and-extract step (success) 13:08:32 INFO - [mozharness: 2016-07-27 20:08:32.267261Z] Running populate-webroot step. 13:08:32 INFO - Running pre-action listener: _resource_record_pre_action 13:08:32 INFO - Running main action method: populate_webroot 13:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:32 INFO - '--tppagecycles', 13:08:32 INFO - '7'], 13:08:32 INFO - 'tests': ['tsvgm']}}, 13:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['damp', 'tps']}, 13:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'tests': ['damp', 'tps']}, 13:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['dromaeo_dom']}, 13:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['basic_compositor_video']}, 13:08:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['a11yr', 13:08:32 INFO - 'ts_paint', 13:08:32 INFO - 'tpaint', 13:08:32 INFO - 'sessionrestore', 13:08:32 INFO - 'sessionrestore_no_auto_restore', 13:08:32 INFO - 'tabpaint']}, 13:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['tsvgx', 13:08:32 INFO - 'tsvgr_opacity', 13:08:32 INFO - 'tart', 13:08:32 INFO - 'tscrollx', 13:08:32 INFO - 'cart']}, 13:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:32 INFO - 'tsvgr_opacity', 13:08:32 INFO - 'tart', 13:08:32 INFO - 'tscrollx', 13:08:32 INFO - 'cart']}, 13:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'talos_options': ['--disable-e10s'], 13:08:32 INFO - 'tests': ['tp5o']}, 13:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'tests': ['tp5o']}, 13:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'talos_options': ['--disable-e10s', 13:08:32 INFO - '--xperf_path', 13:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:32 INFO - 'tests': ['tp5n']}, 13:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:32 INFO - 'talos_options': ['--xperf_path', 13:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:32 INFO - 'tests': ['tp5n']}}, 13:08:32 INFO - 'talos.zip': {'path': '', 13:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:32 INFO - Running post-action listener: _resource_record_post_action 13:08:32 INFO - [mozharness: 2016-07-27 20:08:32.284454Z] Finished populate-webroot step (success) 13:08:32 INFO - [mozharness: 2016-07-27 20:08:32.284542Z] Running create-virtualenv step. 13:08:32 INFO - Running pre-action listener: _resource_record_pre_action 13:08:32 INFO - Running main action method: create_virtualenv 13:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:32 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 13:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:32 INFO - Using real prefix '/usr' 13:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:36 INFO - Installing pip.................done. 13:08:36 INFO - Return code: 0 13:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:36 INFO - Using env: {'DISPLAY': ':0', 13:08:36 INFO - 'HOME': '/home/cltbld', 13:08:36 INFO - 'LANG': 'en_US.UTF-8', 13:08:36 INFO - 'LANGUAGE': 'en_US:en', 13:08:36 INFO - 'LOGNAME': 'cltbld', 13:08:36 INFO - 'MAIL': '/var/mail/cltbld', 13:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:36 INFO - 'MOZ_NO_REMOTE': '1', 13:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:36 INFO - 'NO_EM_RESTART': '1', 13:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:36 INFO - 'PWD': '/builds/slave/test', 13:08:36 INFO - 'SHELL': '/bin/bash', 13:08:36 INFO - 'SHLVL': '1', 13:08:36 INFO - 'TERM': 'linux', 13:08:36 INFO - 'TMOUT': '86400', 13:08:36 INFO - 'USER': 'cltbld', 13:08:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:36 INFO - '_': '/tools/buildbot/bin/python'} 13:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:37 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 13:08:37 INFO - Cleaning up... 13:08:37 INFO - Return code: 0 13:08:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:37 INFO - Using env: {'DISPLAY': ':0', 13:08:37 INFO - 'HOME': '/home/cltbld', 13:08:37 INFO - 'LANG': 'en_US.UTF-8', 13:08:37 INFO - 'LANGUAGE': 'en_US:en', 13:08:37 INFO - 'LOGNAME': 'cltbld', 13:08:37 INFO - 'MAIL': '/var/mail/cltbld', 13:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:37 INFO - 'MOZ_NO_REMOTE': '1', 13:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:37 INFO - 'NO_EM_RESTART': '1', 13:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:37 INFO - 'PWD': '/builds/slave/test', 13:08:37 INFO - 'SHELL': '/bin/bash', 13:08:37 INFO - 'SHLVL': '1', 13:08:37 INFO - 'TERM': 'linux', 13:08:37 INFO - 'TMOUT': '86400', 13:08:37 INFO - 'USER': 'cltbld', 13:08:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:37 INFO - '_': '/tools/buildbot/bin/python'} 13:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:38 INFO - Downloading/unpacking psutil>=3.1.1 13:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:41 INFO - Installing collected packages: psutil 13:08:41 INFO - Running setup.py install for psutil 13:08:41 INFO - building 'psutil._psutil_linux' extension 13:08:41 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 13:08:42 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 13:08:42 INFO - building 'psutil._psutil_posix' extension 13:08:42 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 13:08:42 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 13:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:43 INFO - Successfully installed psutil 13:08:43 INFO - Cleaning up... 13:08:43 INFO - Return code: 0 13:08:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:43 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')]} 13:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:43 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')]} 13:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:43 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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:43 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 13:08:43 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 13:08:43 INFO - Using env: {'DISPLAY': ':0', 13:08:43 INFO - 'HOME': '/home/cltbld', 13:08:43 INFO - 'LANG': 'en_US.UTF-8', 13:08:43 INFO - 'LANGUAGE': 'en_US:en', 13:08:43 INFO - 'LOGNAME': 'cltbld', 13:08:43 INFO - 'MAIL': '/var/mail/cltbld', 13:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:43 INFO - 'MOZ_NO_REMOTE': '1', 13:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:43 INFO - 'NO_EM_RESTART': '1', 13:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:43 INFO - 'PWD': '/builds/slave/test', 13:08:43 INFO - 'SHELL': '/bin/bash', 13:08:43 INFO - 'SHLVL': '1', 13:08:43 INFO - 'TERM': 'linux', 13:08:43 INFO - 'TMOUT': '86400', 13:08:43 INFO - 'USER': 'cltbld', 13:08:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:43 INFO - '_': '/tools/buildbot/bin/python'} 13:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:45 INFO - Installing collected packages: mozsystemmonitor 13:08:45 INFO - Running setup.py install for mozsystemmonitor 13:08:45 INFO - Successfully installed mozsystemmonitor 13:08:45 INFO - Cleaning up... 13:08:45 INFO - Return code: 0 13:08:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:08:45 INFO - Using env: {'DISPLAY': ':0', 13:08:45 INFO - 'HOME': '/home/cltbld', 13:08:45 INFO - 'LANG': 'en_US.UTF-8', 13:08:45 INFO - 'LANGUAGE': 'en_US:en', 13:08:45 INFO - 'LOGNAME': 'cltbld', 13:08:45 INFO - 'MAIL': '/var/mail/cltbld', 13:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:45 INFO - 'MOZ_NO_REMOTE': '1', 13:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:45 INFO - 'NO_EM_RESTART': '1', 13:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:45 INFO - 'PWD': '/builds/slave/test', 13:08:45 INFO - 'SHELL': '/bin/bash', 13:08:45 INFO - 'SHLVL': '1', 13:08:45 INFO - 'TERM': 'linux', 13:08:45 INFO - 'TMOUT': '86400', 13:08:45 INFO - 'USER': 'cltbld', 13:08:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:45 INFO - '_': '/tools/buildbot/bin/python'} 13:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:45 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:47 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 13:08:47 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 13:08:47 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 13:08:47 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 13:08:47 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 13:08:47 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 13:08:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:47 INFO - warning: no files found matching '*.txt' 13:08:47 INFO - no previously-included directories found matching 'build' 13:08:47 INFO - no previously-included directories found matching 'dist' 13:08:47 INFO - no previously-included directories found matching '.git*' 13:08:47 INFO - Installing collected packages: jsonschema, functools32 13:08:47 INFO - Running setup.py install for functools32 13:08:47 INFO - warning: no files found matching '*.txt' 13:08:47 INFO - no previously-included directories found matching 'build' 13:08:47 INFO - no previously-included directories found matching 'dist' 13:08:47 INFO - no previously-included directories found matching '.git*' 13:08:48 INFO - Successfully installed jsonschema functools32 13:08:48 INFO - Cleaning up... 13:08:48 INFO - Return code: 0 13:08:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:08:48 INFO - Using env: {'DISPLAY': ':0', 13:08:48 INFO - 'HOME': '/home/cltbld', 13:08:48 INFO - 'LANG': 'en_US.UTF-8', 13:08:48 INFO - 'LANGUAGE': 'en_US:en', 13:08:48 INFO - 'LOGNAME': 'cltbld', 13:08:48 INFO - 'MAIL': '/var/mail/cltbld', 13:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:48 INFO - 'MOZ_NO_REMOTE': '1', 13:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:48 INFO - 'NO_EM_RESTART': '1', 13:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:48 INFO - 'PWD': '/builds/slave/test', 13:08:48 INFO - 'SHELL': '/bin/bash', 13:08:48 INFO - 'SHLVL': '1', 13:08:48 INFO - 'TERM': 'linux', 13:08:48 INFO - 'TMOUT': '86400', 13:08:48 INFO - 'USER': 'cltbld', 13:08:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:48 INFO - '_': '/tools/buildbot/bin/python'} 13:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:08:48 INFO - Cleaning up... 13:08:48 INFO - Return code: 0 13:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:08:48 INFO - Using env: {'DISPLAY': ':0', 13:08:48 INFO - 'HOME': '/home/cltbld', 13:08:48 INFO - 'LANG': 'en_US.UTF-8', 13:08:48 INFO - 'LANGUAGE': 'en_US:en', 13:08:48 INFO - 'LOGNAME': 'cltbld', 13:08:48 INFO - 'MAIL': '/var/mail/cltbld', 13:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:48 INFO - 'MOZ_NO_REMOTE': '1', 13:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:48 INFO - 'NO_EM_RESTART': '1', 13:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:48 INFO - 'PWD': '/builds/slave/test', 13:08:48 INFO - 'SHELL': '/bin/bash', 13:08:48 INFO - 'SHLVL': '1', 13:08:48 INFO - 'TERM': 'linux', 13:08:48 INFO - 'TMOUT': '86400', 13:08:48 INFO - 'USER': 'cltbld', 13:08:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:48 INFO - '_': '/tools/buildbot/bin/python'} 13:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:50 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 13:08:51 INFO - Downloading docopt-0.6.1.tar.gz 13:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:51 INFO - Running setup.py install for blobuploader 13:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:51 INFO - Running setup.py install for requests 13:08:51 INFO - Running setup.py install for docopt 13:08:51 INFO - Successfully installed blobuploader requests docopt 13:08:51 INFO - Cleaning up... 13:08:51 INFO - Return code: 0 13:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:51 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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:51 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 13:08:51 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 13:08:51 INFO - Using env: {'DISPLAY': ':0', 13:08:51 INFO - 'HOME': '/home/cltbld', 13:08:51 INFO - 'LANG': 'en_US.UTF-8', 13:08:51 INFO - 'LANGUAGE': 'en_US:en', 13:08:51 INFO - 'LOGNAME': 'cltbld', 13:08:51 INFO - 'MAIL': '/var/mail/cltbld', 13:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:51 INFO - 'MOZ_NO_REMOTE': '1', 13:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:51 INFO - 'NO_EM_RESTART': '1', 13:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:51 INFO - 'PWD': '/builds/slave/test', 13:08:51 INFO - 'SHELL': '/bin/bash', 13:08:51 INFO - 'SHLVL': '1', 13:08:51 INFO - 'TERM': 'linux', 13:08:51 INFO - 'TMOUT': '86400', 13:08:51 INFO - 'USER': 'cltbld', 13:08:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:51 INFO - '_': '/tools/buildbot/bin/python'} 13:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:52 INFO - Running setup.py (path:/tmp/pip-tGw7bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:52 INFO - Running setup.py (path:/tmp/pip-fZmTfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:52 INFO - Running setup.py (path:/tmp/pip-7POn1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:52 INFO - Running setup.py (path:/tmp/pip-WiaelZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:52 INFO - Running setup.py (path:/tmp/pip-W4P8LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:52 INFO - Running setup.py (path:/tmp/pip-7jCtWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:52 INFO - Running setup.py (path:/tmp/pip-DjnnNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:52 INFO - Running setup.py (path:/tmp/pip-IgT_ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:52 INFO - Running setup.py (path:/tmp/pip-NbE_fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:52 INFO - Running setup.py (path:/tmp/pip-l9BcY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:52 INFO - Running setup.py (path:/tmp/pip-GQBVhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:52 INFO - Running setup.py (path:/tmp/pip-v_N0oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:52 INFO - Running setup.py (path:/tmp/pip-d60Jr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:52 INFO - Running setup.py (path:/tmp/pip-WKTosZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:53 INFO - Running setup.py (path:/tmp/pip-xrrEcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:53 INFO - Running setup.py (path:/tmp/pip-xjMbcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:53 INFO - Running setup.py (path:/tmp/pip-uSbBe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:53 INFO - Running setup.py install for manifestparser 13:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:53 INFO - Running setup.py install for mozcrash 13:08:53 INFO - Running setup.py install for mozdebug 13:08:53 INFO - Running setup.py install for mozdevice 13:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:53 INFO - Running setup.py install for mozfile 13:08:53 INFO - Running setup.py install for mozhttpd 13:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:53 INFO - Running setup.py install for mozinfo 13:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:53 INFO - Running setup.py install for mozInstall 13:08:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Running setup.py install for mozleak 13:08:54 INFO - Running setup.py install for mozlog 13:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Running setup.py install for moznetwork 13:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Running setup.py install for mozprocess 13:08:54 INFO - Running setup.py install for mozprofile 13:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Running setup.py install for mozrunner 13:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:54 INFO - Running setup.py install for mozscreenshot 13:08:54 INFO - Running setup.py install for moztest 13:08:54 INFO - Running setup.py install for mozversion 13:08:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:55 INFO - Cleaning up... 13:08:55 INFO - Return code: 0 13:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:55 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')]} 13:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 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')]} 13:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:55 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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:55 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 13:08:55 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 13:08:55 INFO - Using env: {'DISPLAY': ':0', 13:08:55 INFO - 'HOME': '/home/cltbld', 13:08:55 INFO - 'LANG': 'en_US.UTF-8', 13:08:55 INFO - 'LANGUAGE': 'en_US:en', 13:08:55 INFO - 'LOGNAME': 'cltbld', 13:08:55 INFO - 'MAIL': '/var/mail/cltbld', 13:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:55 INFO - 'MOZ_NO_REMOTE': '1', 13:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:55 INFO - 'NO_EM_RESTART': '1', 13:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:55 INFO - 'PWD': '/builds/slave/test', 13:08:55 INFO - 'SHELL': '/bin/bash', 13:08:55 INFO - 'SHLVL': '1', 13:08:55 INFO - 'TERM': 'linux', 13:08:55 INFO - 'TMOUT': '86400', 13:08:55 INFO - 'USER': 'cltbld', 13:08:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:55 INFO - '_': '/tools/buildbot/bin/python'} 13:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:55 INFO - Running setup.py (path:/tmp/pip-WjQoL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:55 INFO - Running setup.py (path:/tmp/pip-gHv9bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:55 INFO - Running setup.py (path:/tmp/pip-A5yVBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:55 INFO - Running setup.py (path:/tmp/pip-KS5fFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:55 INFO - Running setup.py (path:/tmp/pip-GWl119-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:55 INFO - Running setup.py (path:/tmp/pip-WAwgwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:55 INFO - Running setup.py (path:/tmp/pip-YnTnam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:55 INFO - Running setup.py (path:/tmp/pip-qY45Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:55 INFO - Running setup.py (path:/tmp/pip-RqH4Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:55 INFO - Running setup.py (path:/tmp/pip-Vjvyoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:55 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)) 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:55 INFO - Running setup.py (path:/tmp/pip-aMXUrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:56 INFO - Running setup.py (path:/tmp/pip-FVVCV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:56 INFO - Running setup.py (path:/tmp/pip-4EMqPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:56 INFO - Running setup.py (path:/tmp/pip-q0repG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:56 INFO - Running setup.py (path:/tmp/pip-xlaXIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:56 INFO - Running setup.py (path:/tmp/pip-4RQSEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:56 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)) 13:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:56 INFO - Running setup.py (path:/tmp/pip-If8Ppe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:56 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)) 13:08:56 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)) 13:08:56 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)) 13:08:56 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)) 13:08:56 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)) 13:08:56 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)) 13:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:58 INFO - Downloading blessings-1.6.tar.gz 13:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:58 INFO - Installing collected packages: blessings 13:08:58 INFO - Running setup.py install for blessings 13:08:58 INFO - Successfully installed blessings 13:08:58 INFO - Cleaning up... 13:08:58 INFO - Return code: 0 13:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:58 INFO - Reading from file tmpfile_stdout 13:08:58 INFO - Current package versions: 13:08:58 INFO - argparse == 1.2.1 13:08:58 INFO - blessings == 1.6 13:08:58 INFO - blobuploader == 1.2.4 13:08:58 INFO - docopt == 0.6.1 13:08:58 INFO - functools32 == 3.2.3-2 13:08:58 INFO - jsonschema == 2.5.1 13:08:58 INFO - manifestparser == 1.1 13:08:58 INFO - mozInstall == 1.12 13:08:58 INFO - mozcrash == 0.17 13:08:58 INFO - mozdebug == 0.1 13:08:58 INFO - mozdevice == 0.48 13:08:58 INFO - mozfile == 1.2 13:08:58 INFO - mozhttpd == 0.7 13:08:58 INFO - mozinfo == 0.9 13:08:58 INFO - mozleak == 0.1 13:08:58 INFO - mozlog == 3.3 13:08:58 INFO - moznetwork == 0.27 13:08:58 INFO - mozprocess == 0.23 13:08:58 INFO - mozprofile == 0.28 13:08:58 INFO - mozrunner == 6.12 13:08:58 INFO - mozscreenshot == 0.1 13:08:58 INFO - mozsystemmonitor == 0.3 13:08:58 INFO - moztest == 0.7 13:08:58 INFO - mozversion == 1.4 13:08:58 INFO - psutil == 3.1.1 13:08:58 INFO - requests == 1.2.3 13:08:58 INFO - wsgiref == 0.1.2 13:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:58 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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:58 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 13:08:58 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 13:08:58 INFO - Using env: {'DISPLAY': ':0', 13:08:58 INFO - 'HOME': '/home/cltbld', 13:08:58 INFO - 'LANG': 'en_US.UTF-8', 13:08:58 INFO - 'LANGUAGE': 'en_US:en', 13:08:58 INFO - 'LOGNAME': 'cltbld', 13:08:58 INFO - 'MAIL': '/var/mail/cltbld', 13:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:58 INFO - 'MOZ_NO_REMOTE': '1', 13:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:58 INFO - 'NO_EM_RESTART': '1', 13:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:58 INFO - 'PWD': '/builds/slave/test', 13:08:58 INFO - 'SHELL': '/bin/bash', 13:08:58 INFO - 'SHLVL': '1', 13:08:58 INFO - 'TERM': 'linux', 13:08:58 INFO - 'TMOUT': '86400', 13:08:58 INFO - 'USER': 'cltbld', 13:08:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:58 INFO - '_': '/tools/buildbot/bin/python'} 13:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 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)) 13:08:59 INFO - Cleaning up... 13:08:59 INFO - Return code: 0 13:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:59 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 0x176b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, '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': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', '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 13:08:59 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 13:08:59 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 13:08:59 INFO - Using env: {'DISPLAY': ':0', 13:08:59 INFO - 'HOME': '/home/cltbld', 13:08:59 INFO - 'LANG': 'en_US.UTF-8', 13:08:59 INFO - 'LANGUAGE': 'en_US:en', 13:08:59 INFO - 'LOGNAME': 'cltbld', 13:08:59 INFO - 'MAIL': '/var/mail/cltbld', 13:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:59 INFO - 'MOZ_NO_REMOTE': '1', 13:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:59 INFO - 'NO_EM_RESTART': '1', 13:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:59 INFO - 'PWD': '/builds/slave/test', 13:08:59 INFO - 'SHELL': '/bin/bash', 13:08:59 INFO - 'SHLVL': '1', 13:08:59 INFO - 'TERM': 'linux', 13:08:59 INFO - 'TMOUT': '86400', 13:08:59 INFO - 'USER': 'cltbld', 13:08:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:59 INFO - '_': '/tools/buildbot/bin/python'} 13:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:59 INFO - Cleaning up... 13:08:59 INFO - Return code: 0 13:08:59 INFO - Running post-action listener: _resource_record_post_action 13:08:59 INFO - Running post-action listener: _start_resource_monitoring 13:08:59 INFO - Starting resource monitoring. 13:08:59 INFO - [mozharness: 2016-07-27 20:08:59.371914Z] Finished create-virtualenv step (success) 13:08:59 INFO - [mozharness: 2016-07-27 20:08:59.372345Z] Running install step. 13:08:59 INFO - Running pre-action listener: _resource_record_pre_action 13:08:59 INFO - Running main action method: install 13:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:59 INFO - Reading from file tmpfile_stdout 13:08:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:59 INFO - Reading from file tmpfile_stdout 13:08:59 INFO - Output received: 13:08:59 INFO - Usage: mozinstall [options] installer 13:08:59 INFO - Options: 13:08:59 INFO - -h, --help show this help message and exit 13:08:59 INFO - -d DEST, --destination=DEST 13:08:59 INFO - Directory to install application into. [default: 13:08:59 INFO - "/builds/slave/test"] 13:08:59 INFO - --app=APP Application being installed. [default: firefox] 13:08:59 INFO - mkdir: /builds/slave/test/build/application 13:08:59 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'] 13:08:59 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 13:09:16 INFO - Reading from file tmpfile_stdout 13:09:16 INFO - Output received: 13:09:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:16 INFO - Running post-action listener: _resource_record_post_action 13:09:16 INFO - [mozharness: 2016-07-27 20:09:16.059122Z] Finished install step (success) 13:09:16 INFO - [mozharness: 2016-07-27 20:09:16.059398Z] Running run-tests step. 13:09:16 INFO - Running pre-action listener: _resource_record_pre_action 13:09:16 INFO - Running main action method: run_tests 13:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:16 INFO - Python 2.7.3 13:09:16 INFO - Return code: 0 13:09:16 INFO - grabbing minidump binary from tooltool 13:09:16 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')]} 13:09:16 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 0x1a2a3b0>, '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 0x1a2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:16 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 13:09:16 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 13:09:16 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 13:09:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:16 INFO - Return code: 0 13:09:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:16 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/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 13:09:16 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/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 13:09:16 INFO - Using env: {'DISPLAY': ':0', 13:09:16 INFO - 'HOME': '/home/cltbld', 13:09:16 INFO - 'LANG': 'en_US.UTF-8', 13:09:16 INFO - 'LANGUAGE': 'en_US:en', 13:09:16 INFO - 'LOGNAME': 'cltbld', 13:09:16 INFO - 'MAIL': '/var/mail/cltbld', 13:09:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:16 INFO - 'MOZ_NO_REMOTE': '1', 13:09:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:16 INFO - 'NO_EM_RESTART': '1', 13:09:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:16 INFO - 'PWD': '/builds/slave/test', 13:09:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:16 INFO - 'SHELL': '/bin/bash', 13:09:16 INFO - 'SHLVL': '1', 13:09:16 INFO - 'TERM': 'linux', 13:09:16 INFO - 'TMOUT': '86400', 13:09:16 INFO - 'USER': 'cltbld', 13:09:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469649532.231578-1874100314', 13:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:16 INFO - '_': '/tools/buildbot/bin/python'} 13:09:16 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/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 13:09:16 INFO - mozversion application_buildid: 20160727114841 13:09:16 INFO - mozversion application_changeset: ca76fbe8cb78f894b835dee6cdb2bced219af56c 13:09:16 INFO - mozversion application_display_name: Nightly 13:09:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:16 INFO - mozversion application_name: Firefox 13:09:16 INFO - mozversion application_remotingname: firefox 13:09:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:09:16 INFO - mozversion application_vendor: Mozilla 13:09:16 INFO - mozversion application_version: 50.0a1 13:09:16 INFO - mozversion platform_buildid: 20160727114841 13:09:16 INFO - mozversion platform_changeset: ca76fbe8cb78f894b835dee6cdb2bced219af56c 13:09:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:09:16 INFO - mozversion platform_version: 50.0a1 13:09:16 INFO - using testdate: 1469650156 13:09:16 INFO - actual date: 1469650156 13:09:16 INFO - starting webserver on 'localhost:37171' 13:09:16 INFO - SUITE-START | Running 2 tests 13:09:16 INFO - TEST-START | dromaeo_css 13:09:16 INFO - operating with platform_type : linux_ 13:09:16 INFO - Initialising browser for dromaeo_css test... 13:09:16 INFO - TEST-INFO | started process 3291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXRFYT/profile http://localhost:37171/getInfo.html) 13:09:24 INFO - PROCESS | 3291 | JavaScript error: , line 0: uncaught exception: undefined 13:09:25 INFO - PROCESS | 3291 | __metrics Screen width/height:1600/1200 13:09:25 INFO - PROCESS | 3291 | colorDepth:24 13:09:25 INFO - PROCESS | 3291 | Browser inner width/height: 1024/697 13:09:25 INFO - PROCESS | 3291 | __metrics 13:09:26 INFO - PROCESS | 3291 | 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" 13:09:26 INFO - PROCESS | 3291 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:26 INFO - PROCESS | 3291 | console.error: PushService: 13:09:26 INFO - PROCESS | 3291 | stateChangeProcessEnqueue: Error transitioning state 13:09:26 INFO - PROCESS | 3291 | UnknownError 13:09:27 INFO - TEST-INFO | 3291: exit 0 13:09:27 INFO - Browser initialized. 13:09:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:27 INFO - TEST-INFO | started process 3368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXRFYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:39 INFO - PROCESS | 3368 | RSS: Main: 158978048 13:09:39 INFO - PROCESS | 3368 | 13:10:30 INFO - PROCESS | 3368 | 1469650230107 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] 13:12:43 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37171/tests/dromaeo/cssquery-ext.html) 13:12:44 INFO - PROCESS | 3368 | RSS: Main: 234487808 13:12:44 INFO - PROCESS | 3368 | 13:15:47 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-ext.html (next: http://localhost:37171/tests/dromaeo/cssquery-jquery.html) 13:15:47 INFO - PROCESS | 3368 | RSS: Main: 248741888 13:15:47 INFO - PROCESS | 3368 | 13:18:50 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37171/tests/dromaeo/cssquery-mootools.html) 13:18:50 INFO - PROCESS | 3368 | RSS: Main: 189181952 13:18:50 INFO - PROCESS | 3368 | 13:21:52 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37171/tests/dromaeo/cssquery-prototype.html) 13:21:53 INFO - PROCESS | 3368 | RSS: Main: 231591936 13:21:53 INFO - PROCESS | 3368 | 13:24:56 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37171/tests/dromaeo/cssquery-yui.html) 13:24:57 INFO - PROCESS | 3368 | RSS: Main: 191160320 13:24:57 INFO - PROCESS | 3368 | 13:27:59 INFO - PROCESS | 3368 | Cycle 1(1): loaded http://localhost:37171/tests/dromaeo/cssquery-yui.html (next: http://localhost:37171/tests/dromaeo/cssquery-dojo.html) 13:28:00 INFO - PROCESS | 3368 | RSS: Main: 275484672 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | __start_tp_report 13:28:00 INFO - PROCESS | 3368 | _x_x_mozilla_page_load 13:28:00 INFO - PROCESS | 3368 | _x_x_mozilla_page_load_details 13:28:00 INFO - PROCESS | 3368 | |i|pagename|runs| 13:28:00 INFO - PROCESS | 3368 | |0;dojo.html;2606.491734111849;2608.413107050914;2637.7494138056877;2643.2863126955713;2650.297671117153;4560.2019646561885;4644.442666879971;4717.245240761479;4727.574518293353;4727.739974301417;4712.811487540503;4717.78769955352;4775.212090005154;4792.448868380137;4825.71045737256;4293.65650747941;4327.675424343187;4396.098799746044;4444.97777511112;4518.231900576893;4443.333499974998;4473.843415480459;4479.104179164164;4495.078508905683;4512.932306015412;4224.493060832689;4305.720128191658;4323.286657701476;4360.389545463638;4386.166628340637;4336.718113322656;4342.196693611692;4386.758728269944;4406.889827754332;4412.624926881219;4345.087531618364;4358.411614432042;4364.236258654754;4394.60448559628;4413.360062790877;4631.490536041033;4672.3692301539195;4749.620030397595;4764.595009424203;4799.712017278975;5046.747662616891;5081.339425874613;5082.644214904958;5083.949160508385;5107.055194788939;5111.488851114858;5126.666766660155;5131.743412829381;5162.303089082963;5174.508421699932;4631.050634619928;4774.427068751772;4842.249451334978;4848.0788650156355;4898.485659005753;5321.547668448148;5370.087085195526;5378.542823859937;5379.78480860769;5381.623286369917;5112.897742045213;5129.846104616868;5148.613853960968;5150.098732721759;5153.4073581538605;4898.853034408973;5004.374453193351;5027.1705168647495;5038.521340472649;5116.667416617908;5015.4733752956145;5025;5026.447090820006;5029.346184995927;5085.1355269604255;4985.52637499437;4987.4015118185325;4989.12690279207;4989.775460104304;5038.84883453497;4184.476940382452;4213.220554197484;4216.494020717533;4268.509121451011;4269.295566231599;3728.8694895678523;3737.2338670572467;3770.981145094312;3772.679322257584;3774.094217387862;4304.698671092993;4362.498312694081;4404.295312749945;4414.227510185769;4463.285874260103;5053.191489361758;5063.3923929128005;5070.847874563769;5078.085944529947;5127.282180494733;4360.106178233518;4362.476502819682;4369.9126017479475;4402.843813810727;4416.514183439819;4449;4511.097780443924;4517.796699148546;4552.795124219418;4563.566461186182;4738.005018945991;4740.265258884879;4743.980044290494;4747.145513807548;4794.376731024944;5027.64806463544;5041.193409054534;5044.672096313728;5092.363454568179;5124.333836601218;4647.721136731807;4671.556202160925;4672.065586882569;4704.059188162313;4769.66612337133;4936.03747269279;4940.061388336205;4944.417449251918;4948.985457981177;4984.925226121683;4987.426445958761;4989.900201996013;5012.223105418666;5017.1721665924715;5039.84880453587;4809.2305231162845;4945.925811112908;4961.776720047535;4963.156263435152;5037.244413337882;4963.5780958618925;4964.627652925973;4969.055879382906;4971.527704868032;5022.0960227158;4896.632752543503;4900.2894580286375;4956.330895329084;4966.478519755518;4981.277714731416;4847.054824309226;4919.942212424203;4971.328870602567;4976;5014.07239660664;4856.805727770849;4874.488178741323;4874.634402419903;4875.829345972874;4928.778204980713 13:28:00 INFO - PROCESS | 3368 | |1;ext.html;573;582.4437662032758;582.4466756581248;590.5688847141587;596.0284735880514;27063;38861.61138388615;40172.59827401725;40184.79907600458;44048.11903761931;39658.40512392309;39985.200295994066;40042;40171;40313.7984310078;7555.84888302235;7753.728619498319;7774.494657847222;7781.41639377049;7788.14330423653;7347.191808901017;9556.283278754086;9780.559874805615;9799.16707079899;10178.44018578978;9935.105840474356;10009;10026.39841609502;10037.146842518394;10039.69880903574;9546.522673866313;9607.327487075907;9607.90392096077;9614.134727874525;9619.663311784088;9665.516724163763;9729.464879431629;9730.805383892353;9734.610615575368;9734.707958761248;37961;38246.42630360547;38306;38317.61682383168;38321.23357532862;2765.198092553157;2888.6244788177614;2942.3085574889883;3036.5445183222473;3268.9866141495972;29176.270593235127;29776.404471910657;29865.55201671977;30097.699023009707;30343.089707308816;2961.304093538038;2974.152366575537;3053;3053.3130045739754;3123.375324935022;255742;255933;256832.99999999814;256930;257963;31151.22121946924;52037.47962520326;52337.7383113082;52342.691432714484;52436.21345679818;31173.688263117532;33230.66769332276;33305;33345.333093338;33345.333093338486;12697.55558555446;12805.487780488862;12857.614271571867;12859.16415432994;12859.357032148355;9429.868415790012;9575.377600456088;10022.398656080659;10118.949405252926;10122.240831937634;7346.33882950537;7399.963000184965;7547.622618869034;7787.493812902143;7818.92181078182;3032.378362435695;3133.310671652233;3139.7174254316765;3176.857041433141;3181.729552988022;874.0691163910415;884.4030279561271;893.1247377570018;900.1268769293774;904.5884122724144;27677;28367.89504687557;28558.857205713837;28795.424091518053;29204.415911681648;949.6581230756922;960.6493629825063;986.1174249047062;992.374803873555;1085.973754801705;14920.40318387274;15062.774058389134;15132.924335378253;15541.689166216613;15573.14347710864;398820;402362;402393.832431727;402831;402940;48039.75980120147;48508.514914851105;48631.5136848627;48701.51298487041;48723.75638121787;1173.8532683414574;1197.6167626359656;1212.8241404996227;1218.65268398506;1222.3093951917137;25391.61912571276;27257.86371068132;27588.517033467084;27687.58468622932;27974.58038129389;37149.628503714615;41365.37951930663;41582.79208603938;41605.1678966425;41611.7919410401;327320;330672.5861043197;330857;331086;331893;21872.89063554672;24308.75691243065;24828.255152345457;24857.627135593342;25185.62221566641;40689.1862162761;40982.38526422166;41078.79460602678;41677.79161104175;41988.790056049525;34565.82717086399;34927;35050.82474587611;35136.82431587826;35439.46840797442;34447.31105377928;34903.12742181466;35281.82359088188;35452.64547354494;35632.28735425329;34707.82646086753;35126;35318.64681353154;35597.82201088978;35757.82121089378;30048.24879378033;32622.184445389055;32655.18362040873;32779;32940;24630.753692462848;25097.49805003853;25198.496030078928;25311.114111006027;25638.743612563634 13:28:00 INFO - PROCESS | 3368 | |2;jquery.html;357.7174032514313;359.91901822090034;367.36079222153455;376.4804569693822;381.38483522283144;15899.920500397497;16715.916420417896;17373;17424.041677707723;17462.738058929128;15063.096214227155;15897.205139742995;15937.362505499796;15995.680086398264;16020.519384418458;4871.683340582859;5107.8467645970495;5118.334616499868;5118.897622047557;5122.641415100945;3740.36413809653;3882.1265215326466;5037.017781532602;5518.889622207574;5755.65466072037;5834.941650583482;5840.182374467578;5846.50304724099;5847.006008978463;5852.063669812831;5649.717514124298;5947.910781338283;5957.136215248808;5965.880682386328;5968.134620480006;5027.949720502785;5225.294585231021;5226.660267082628;5239.528442440199;5241.895162096736;16975.91512042444;16987.3205071797;17188.828111718973;17195.828041719673;17261.223244954006;1995.6607376745987;2067.6795096760025;2107.9262225822176;2366.7041619797524;2440.9145679901117;13397.799033014513;13452.663683407894;13548.390322435514;13553.186808791505;14070.718585628332;1727.7322015087557;1801.927922883083;1845.308009496439;1862.8695991280615;1876.5496280892487;71543.2845671547;72291.27708722898;72336;73113;73457;9637.22902167825;9777.804443911082;9872.802543949081;10040.899591004143;10104.747381315527;13310.600681979557;13386.062975591614;13388.06283560161;13392.933035334761;13398.531051413154;6870.725170993204;7258.383037441771;7271.272872712792;7365;7382.18795932447;6932.202796678446;6932.410745086724;7127.8574428512175;7154.964225178945;7167.569945803269;4114.300568903293;4235.555266697014;4236.809343579484;4337.696361254745;4340.739555626609;1640.409452597064;1672.3728601774335;1698.4989428118736;1703.3271857616173;1718.707819670659;876.6756300168978;893.6425429828121;901.9819603607891;913.981720365589;933.2580598424133;15561.766573501407;16699;17029.40397086096;17240.568985775204;17689.20398582067;828.362161135922;839.689314953459;849.8980122385353;872.6465781358434;907.2832462354665;9094.226990705733;9794.902050979541;9855.55649995752;9868.654597089067;9971.202303815677;425362;430623;434868;437774;439292;77075;78919;80438;81623.59188204021;82308;818.378032695144;860.7589874835056;866.9046404895456;889.3952112563519;890.1499068389672;15084.86863485221;15854.52436426863;15972.68054638924;16312.429064982669;16538.917305413397;37723.81138094292;38128.80935595415;38407;39963.40054899121;40551.59448405478;51851.2222316658;52741;53309.7334513325;53402;54350.7282463601;6490.221173459215;7146.3568278855155;7252.818679533054;7498.08112122328;7527.397808175223;9786.892679013774;11077.833832492357;12251.326177060348;12256.877431225574;12427.19805628197;10577.100946419641;10593.152547796311;10721.892781072402;10942;10990.17573681993;10705.89294107049;10711.839322410015;10841.67474975752;10863.837042444211;10978.780424391627;10684.145268378667;10771.246012779031;10800.135989120694;11070.169737269576;11222.10223182127;6835.179778426621;6919.861602768017;7001.754938577125;7004.579725216503;7052.682629281592;10711;10732.46337683097;10803.783924321313;10813.62152324665;11242.606508772154 13:28:00 INFO - PROCESS | 3368 | |3;mootools.html;1334.2128144394808;1385.8891288696905;1425.9714805703886;1657.668466306739;1693.8306169383063;7209.315115064067;7755.806104847382;7761;7763.573003484806;7766.378689704824;6445.677716114187;6650.800475985716;6653.900191497131;6852.6231057291825;7622.199669034755;1892.1107079672565;2072.616565935307;2153.924612638558;2155.2241193170526;2175.967360489594;2170.8263338932925;2171.815395691368;2189.967150492736;2191.561687662466;2195.2316689158824;2088.4256829371893;2165.8700477971292;2168.642174041281;2169.4142581503065;2170.0885628036262;2149.720536330283;2155.3749412670386;2158.2554018863466;2187.9453013674624;2192.7478339990944;2117.7776333484917;2127.968080478794;2148.6562150055915;2150.806427421524;2152.5802468518646;7746.070471543395;7820.45256832022;7831.765047048598;7832.686692532349;7838.960805195995;4338.305871060616;4408.338749187616;4424.336349547561;4470.173017991649;4479.888002799924;2681.276055465033;2780.624615676878;2845.530487469565;2854.1865568312933;2860.7139286071433;875.2123089219754;878.5255961780631;889.8665200220019;900.8333458310234;908.2098574240453;10356.533955972;10388.896111038868;10400.94799526005;10405.635802746943;10431.79136417275;3826.5025546678753;4043.959560404417;4186.267403204427;4193.91612167761;4196.727212731163;8893.155150260714;8907.955460222787;8909.465432074096;8933.374663773473;8943.552822358986;4212.136512015091;4217.030083080908;4219.746815191098;4221.303484924953;4239.533651298355;3734.178480734234;3735.7758534488016;3737.6075512071384;3739.9439008414897;3745.5318085239346;3263.2494526259093;3379.273456206927;3395.37185620656;3452.016175390052;3520.894373168809;968.1045033344128;988.1353815411514;988.268681175939;989.5349185882624;998.5257002923698;765.1812560560259;827.4249396669258;836.2306677856386;836.3768992100923;843.5360551696542;4959.553640172402;5034.270030845581;5069.467705890902;5137.357830271216;5329.786808527693;804.5534728225774;811.7645882694071;834.6536187482249;881.167296904432;908.3596064774318;3441.483777433405;3474.8957531274104;3546.414841551167;3592.604813470516;3617.5478065241846;9114.817703646022;9600.567974441166;9600.75998100039;9609.663661771805;9627.277954153467;9447.244220462346;9470.14768670823;9532.094451027142;9544.141027307576;9557.713268601952;7143.4999550031;7210.459215558854;7357.963210184022;7373.262673732584;7375.299346562068;4979.477154898684;5028.723420211923;5099.87250318745;5147.485251474973;5219.086659834438;8612.138786121337;8776.473411595325;8798.516081615573;8827.337949653931;8864.911350886408;8783.912160878564;8877.778055548404;9088.409253398508;9127.954360228156;9133.315001375056;5296.126139186991;5704.743286552032;5967.164596956342;6041.456268935817;6046.123312119806;6773;6988.091548098715;7006.579605223703;7012.403945664676;7026.367626913602;6379.553431259767;6385.233771947396;6390.968045159744;6451.548391612542;6487.643179625166;6280.685965701605;6329.145565348619;6392.904106438315;6397.552171347961;6453.193350831146;5636.943630563642;5716.142578613241;5726.4273572642405;5728.455796699307;5729.742161602655;4172.770497622539;4180.937285940774;4194.958050419456;4235.682323825787;4249.235137675249;4439.334099885043;4520.502744698147;4549.886252843706;4650.255959046536;4727.220008698526 13:28:00 INFO - PROCESS | 3368 | |4;prototype.html;285.7371218478998;293.520094645255;296.55368670151444;301.7163865965992;302.9015569939769;4579.908401831962;4775.546323099305;4813.759312034402;4820.25286080658;4837.863102170992;4615.8153673853;4730.810767569302;4768;4803.279508073791;4804.90390192196;3778.414345776409;3779.924401511968;3789.450529673196;3792.2036372361836;3797.164623782777;3561.1240662424507;3612.9277414451694;3765.3034188675047;3770.4344348347695;3806.7525610835346;3737.6075512071247;3737.9813100934457;3738.439234114891;3742.4760533525327;3763.3468404774567;3727.8881633551036;3730.3658378075656;3732.197577520819;3736.2527494500937;3739.8967304645194;3293.1602441377536;3295.1597342677705;3298.191942973963;3299.9110293603053;3303.0916497963253;4549.067441174584;4654.650901182425;4669.182892993713;4677.497538816717;4710.646701497401;4256.765877876715;4264.701470897038;4278.957210427887;4283.678724095674;4288.506821715511;4979.253112033188;4993.375828021497;5005.324281222025;5017.322661440695;5019.598432125421;3366.309906469168;3453.2920751245933;3477.7217822574385;3482.4253998090285;3494.8776792812127;5197.752539390519;5229.294045303874;5233.450487698813;5235.319408476912;5249.081410753103;3583.6595523425235;3587.7847329160336;3593.7484376093944;3595.3528364894046;3634.582023067381;3442.2599141184264;3590.8204589770407;3675.2649470106085;3675.3568125577917;3677.558692956862;4166.270902592034;4175.519815221228;4175.770332631734;4179;4202.285611446062;5033.194688849767;5034.295198672189;5055.418626857959;5108.386993560796;5108.463611320833;1220.9389530523615;1246.2771592476342;1258.8237646729465;1268.3594784633701;1268.4101892619792;850.6427300533791;875.9737207883646;879.1999280654574;883.1433509495779;883.2007033634571;4458;4462.308342206963;4479.17135329965;4487.573680500347;4495.775211239425;5125.103106956268;5165.070287348313;5165.793368265227;5203.947960520346;5205.973970130125;4351.108022855307;4403.889902752393;4447.666425018137;4466.196084704719;4500.437445319335;2442.3283597010964;2459.2007597530874;2462.1997850698594;2476.3809047738064;2492.9529597569062;4330.501992270866;4334.523202447728;4348.804303806336;4353.34699795027;4390.736555806662;4478.776061196927;4638.744869032168;4669.7431641260055;4672.275797251432;4692.738546710004;4251.702380833312;4295.312749960054;4307.612314891675;4308.569143085666;4346.7609281489185;4555.3850230218495;4557.521460246627;4588.977055114703;4609.492955774929;4618.376519169869;4299.333603291495;4471.128130014616;4490.438695163105;4505.61702255312;4547.976150612945;4295.548967358507;4314.827406903689;4327.242732521733;4349.652027837828;4362.3892655027685;3344.357957213871;3353.5472711184652;3357.867753976194;3358.639750900889;3367.3602015616952;4592.632589392907;4603.631709463168;4603.907921841612;4625.629949603956;4630.305454181899;4722.787474563722;5058.266551350107;5062.443131255485;5067.2652465391575;5075.974620126875;5043.9243411348125;5048.64659473848;5072.847814565569;5084.872878178076;5123.38519377677;4597.793099310472;4786.234202527578;5006.349174607278;5014.545781723259;5051.2423136529815;5101.642884998015;5104.540591346797;5111.4888511150075;5113.616478764182;5123.487651234846;4976.129177394014;4976.253561965734;4986.7283842621355;5003.124453220745;5007.223880298559 13:28:00 INFO - PROCESS | 3368 | |5;yui.html;600.1208229943135;611.3550204534216;627.3820287017287;681.9897701534475;702.4310308649993;11719.53121875125;11931.64205073847;12389.876101238984;12446.19099758515;12652.936735316322;12009.819852702216;12103.27380357177;12105.878941210585;12134.575289864857;12175.57385491508;624.3818619566619;738.1511262048647;749.9325060744532;750.7560042986024;751.0611735330837;635.209164590086;748.7304570354668;756.4062211164237;769.1116760142017;773.0607312115778;810.5947026486757;812.4962523235603;813.979650508739;814.0638265994095;814.0882211922655;649.3538928765909;806.3871457692137;807.3420162567488;807.4912804932914;807.8505476486839;570.3640440908357;573.2833957553058;584.8684046089638;586.1178925716812;587.1369087441454;11972.521099156023;11993.100517461138;11995.28028318295;11995.760084798343;12038.33789141597;11140.498677559448;11486.770264594661;11597.13021523389;11684.824727629093;11780.469878855472;11499.576672144976;11547.191696581243;11796.764064718658;11864.703382415422;11987.280763154151;4089.8568550100604;4104.056067104582;4111.09555897702;4243.702940794145;4251.681123915719;59843.70078149625;60778.392216077715;61455;61538.69230653863;62066.68966655138;9189.494577798152;9227.307951903635;9351.766205844908;9449;9482.715518534455;17396.130193490273;17404.477865664052;17429.21568529419;17449.651006979788;17449.82550174482;6476.319986401454;6486.902696459557;6490.188726409199;6490.318516555693;6494.318096599884;3487.3722729908354;3622.9637703622625;3625.220577575834;3686.7419280650633;3704.2221133561716;2617.1101825379465;2693.165118813174;2705.580635001578;2711.796615253864;2717.2120085175475;464.4612249790227;481.12435367630576;485.861529464101;486.4527406667499;493.6001838510818;526.4419715102005;549.884524249904;553.8615346163459;554.9372950799255;565.5193085876972;6815.829604259933;6866.622335771581;7013.929860701328;7466.290702383265;7756.534607923542;412.38966329832016;487.3080226078976;526.9104252277122;540.6242661350402;544.1864412703035;3459.498372735939;3545.06055895188;3627.2020155565733;3665.2852693725;3703.981480092636;79126.6043669778;81657;82109.17890821135;92513.53743231241;96320;48142.5185748145;55237.72381138069;77730.22269777342;80800.59599701964;82327;71909.99999999895;73312.63343683354;73682;74393.62803186057;74462.6276868623;8130.67477300925;8470.661173553235;8586.141385861614;8611.913880861362;8798.12018798115;30322.69677303199;31518;31676.366472670878;42225.78887105545;42237.155256894075;38745.806270969595;40034.39948400718;40046.59953400429;40487.595124048385;41516.58483415127;11159.81589591346;11329.773404532029;11566.248193867708;11675;12074.698132546757;12662.746745065231;12702.87297127017;12952;12975.545855894998;13331.200127992352;11421.200515964136;11438.370889601152;11753.353565553976;12183.451744671334;12217.633470995885;11754.29474231549;11848.111391645489;12164.878351216375;12363.505459781509;12519.061070419937;10895.618653347095;11087.611933582608;11261.549538018387;11546.0763138947;11905.702357440787;9129.589168487566;9593.568289426852;9621.663241786504;9704.75738106553;10128.949355253177;8775.122487751174;9020.954895225745;9437.386569873212;9797.804043918939;9816.422996592157 13:28:00 INFO - PROCESS | 3368 | __end_tp_report 13:28:00 INFO - PROCESS | 3368 | __start_cc_report 13:28:00 INFO - PROCESS | 3368 | _x_x_mozilla_cycle_collect,1095 13:28:00 INFO - PROCESS | 3368 | __end_cc_report 13:28:00 INFO - PROCESS | 3368 | __startTimestamp1469651280185__endTimestamp 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | ------- Summary: start ------- 13:28:00 INFO - PROCESS | 3368 | Number of tests: 6 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#0] dojo.html Cycles:165 Average:4692.06 Median:4825.71 stddev:500.06 (10.4%) stddev-sans-first:474.07 13:28:00 INFO - PROCESS | 3368 | Values: 2606.5 2608.4 2637.7 2643.3 2650.3 4560.2 4644.4 4717.2 4727.6 4727.7 4712.8 4717.8 4775.2 4792.4 4825.7 4293.7 4327.7 4396.1 4445.0 4518.2 4443.3 4473.8 4479.1 4495.1 4512.9 4224.5 4305.7 4323.3 4360.4 4386.2 4336.7 4342.2 4386.8 4406.9 4412.6 4345.1 4358.4 4364.2 4394.6 4413.4 4631.5 4672.4 4749.6 4764.6 4799.7 5046.7 5081.3 5082.6 5083.9 5107.1 5111.5 5126.7 5131.7 5162.3 5174.5 4631.1 4774.4 4842.2 4848.1 4898.5 5321.5 5370.1 5378.5 5379.8 5381.6 5112.9 5129.8 5148.6 5150.1 5153.4 4898.9 5004.4 5027.2 5038.5 5116.7 5015.5 5025.0 5026.4 5029.3 5085.1 4985.5 4987.4 4989.1 4989.8 5038.8 4184.5 4213.2 4216.5 4268.5 4269.3 3728.9 3737.2 3771.0 3772.7 3774.1 4304.7 4362.5 4404.3 4414.2 4463.3 5053.2 5063.4 5070.8 5078.1 5127.3 4360.1 4362.5 4369.9 4402.8 4416.5 4449.0 4511.1 4517.8 4552.8 4563.6 4738.0 4740.3 4744.0 4747.1 4794.4 5027.6 5041.2 5044.7 5092.4 5124.3 4647.7 4671.6 4672.1 4704.1 4769.7 4936.0 4940.1 4944.4 4949.0 4984.9 4987.4 4989.9 5012.2 5017.2 5039.8 4809.2 4945.9 4961.8 4963.2 5037.2 4963.6 4964.6 4969.1 4971.5 5022.1 4896.6 4900.3 4956.3 4966.5 4981.3 4847.1 4919.9 4971.3 4976.0 5014.1 4856.8 4874.5 4874.6 4875.8 4928.8 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#1] ext.html Cycles:180 Average:47054.99 Median:34988.91 stddev:88434.00 (252.7%) stddev-sans-first:88613.22 13:28:00 INFO - PROCESS | 3368 | Values: 573.0 582.4 582.4 590.6 596.0 27063.0 38861.6 40172.6 40184.8 44048.1 39658.4 39985.2 40042.0 40171.0 40313.8 7555.8 7753.7 7774.5 7781.4 7788.1 7347.2 9556.3 9780.6 9799.2 10178.4 9935.1 10009.0 10026.4 10037.1 10039.7 9546.5 9607.3 9607.9 9614.1 9619.7 9665.5 9729.5 9730.8 9734.6 9734.7 37961.0 38246.4 38306.0 38317.6 38321.2 2765.2 2888.6 2942.3 3036.5 3269.0 29176.3 29776.4 29865.6 30097.7 30343.1 2961.3 2974.2 3053.0 3053.3 3123.4 255742.0 255933.0 256833.0 256930.0 257963.0 31151.2 52037.5 52337.7 52342.7 52436.2 31173.7 33230.7 33305.0 33345.3 33345.3 12697.6 12805.5 12857.6 12859.2 12859.4 9429.9 9575.4 10022.4 10118.9 10122.2 7346.3 7400.0 7547.6 7787.5 7818.9 3032.4 3133.3 3139.7 3176.9 3181.7 874.1 884.4 893.1 900.1 904.6 27677.0 28367.9 28558.9 28795.4 29204.4 949.7 960.6 986.1 992.4 1086.0 14920.4 15062.8 15132.9 15541.7 15573.1 398820.0 402362.0 402393.8 402831.0 402940.0 48039.8 48508.5 48631.5 48701.5 48723.8 1173.9 1197.6 1212.8 1218.7 1222.3 25391.6 27257.9 27588.5 27687.6 27974.6 37149.6 41365.4 41582.8 41605.2 41611.8 327320.0 330672.6 330857.0 331086.0 331893.0 21872.9 24308.8 24828.3 24857.6 25185.6 40689.2 40982.4 41078.8 41677.8 41988.8 34565.8 34927.0 35050.8 35136.8 35439.5 34447.3 34903.1 35281.8 35452.6 35632.3 34707.8 35126.0 35318.6 35597.8 35757.8 30048.2 32622.2 32655.2 32779.0 32940.0 24630.8 25097.5 25198.5 25311.1 25638.7 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#2] jquery.html Cycles:180 Average:25851.35 Median:214799.40 stddev:71475.53 (33.3%) stddev-sans-first:71650.41 13:28:00 INFO - PROCESS | 3368 | Values: 357.7 359.9 367.4 376.5 381.4 15899.9 16715.9 17373.0 17424.0 17462.7 15063.1 15897.2 15937.4 15995.7 16020.5 4871.7 5107.8 5118.3 5118.9 5122.6 3740.4 3882.1 5037.0 5518.9 5755.7 5834.9 5840.2 5846.5 5847.0 5852.1 5649.7 5947.9 5957.1 5965.9 5968.1 5027.9 5225.3 5226.7 5239.5 5241.9 16975.9 16987.3 17188.8 17195.8 17261.2 1995.7 2067.7 2107.9 2366.7 2440.9 13397.8 13452.7 13548.4 13553.2 14070.7 1727.7 1801.9 1845.3 1862.9 1876.5 71543.3 72291.3 72336.0 73113.0 73457.0 9637.2 9777.8 9872.8 10040.9 10104.7 13310.6 13386.1 13388.1 13392.9 13398.5 6870.7 7258.4 7271.3 7365.0 7382.2 6932.2 6932.4 7127.9 7155.0 7167.6 4114.3 4235.6 4236.8 4337.7 4340.7 1640.4 1672.4 1698.5 1703.3 1718.7 876.7 893.6 902.0 914.0 933.3 15561.8 16699.0 17029.4 17240.6 17689.2 828.4 839.7 849.9 872.6 907.3 9094.2 9794.9 9855.6 9868.7 9971.2 425362.0 430623.0 434868.0 437774.0 439292.0 77075.0 78919.0 80438.0 81623.6 82308.0 818.4 860.8 866.9 889.4 890.1 15084.9 15854.5 15972.7 16312.4 16538.9 37723.8 38128.8 38407.0 39963.4 40551.6 51851.2 52741.0 53309.7 53402.0 54350.7 6490.2 7146.4 7252.8 7498.1 7527.4 9786.9 11077.8 12251.3 12256.9 12427.2 10577.1 10593.2 10721.9 10942.0 10990.2 10705.9 10711.8 10841.7 10863.8 10978.8 10684.1 10771.2 10800.1 11070.2 11222.1 6835.2 6919.9 7001.8 7004.6 7052.7 10711.0 10732.5 10803.8 10813.6 11242.6 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#3] mootools.html Cycles:180 Average:4943.53 Median:5483.37 stddev:2810.03 (51.2%) stddev-sans-first:2804.82 13:28:00 INFO - PROCESS | 3368 | Values: 1334.2 1385.9 1426.0 1657.7 1693.8 7209.3 7755.8 7761.0 7763.6 7766.4 6445.7 6650.8 6653.9 6852.6 7622.2 1892.1 2072.6 2153.9 2155.2 2176.0 2170.8 2171.8 2190.0 2191.6 2195.2 2088.4 2165.9 2168.6 2169.4 2170.1 2149.7 2155.4 2158.3 2187.9 2192.7 2117.8 2128.0 2148.7 2150.8 2152.6 7746.1 7820.5 7831.8 7832.7 7839.0 4338.3 4408.3 4424.3 4470.2 4479.9 2681.3 2780.6 2845.5 2854.2 2860.7 875.2 878.5 889.9 900.8 908.2 10356.5 10388.9 10400.9 10405.6 10431.8 3826.5 4044.0 4186.3 4193.9 4196.7 8893.2 8908.0 8909.5 8933.4 8943.6 4212.1 4217.0 4219.7 4221.3 4239.5 3734.2 3735.8 3737.6 3739.9 3745.5 3263.2 3379.3 3395.4 3452.0 3520.9 968.1 988.1 988.3 989.5 998.5 765.2 827.4 836.2 836.4 843.5 4959.6 5034.3 5069.5 5137.4 5329.8 804.6 811.8 834.7 881.2 908.4 3441.5 3474.9 3546.4 3592.6 3617.5 9114.8 9600.6 9600.8 9609.7 9627.3 9447.2 9470.1 9532.1 9544.1 9557.7 7143.5 7210.5 7358.0 7373.3 7375.3 4979.5 5028.7 5099.9 5147.5 5219.1 8612.1 8776.5 8798.5 8827.3 8864.9 8783.9 8877.8 9088.4 9128.0 9133.3 5296.1 5704.7 5967.2 6041.5 6046.1 6773.0 6988.1 7006.6 7012.4 7026.4 6379.6 6385.2 6391.0 6451.5 6487.6 6280.7 6329.1 6392.9 6397.6 6453.2 5636.9 5716.1 5726.4 5728.5 5729.7 4172.8 4180.9 4195.0 4235.7 4249.2 4439.3 4520.5 4549.9 4650.3 4727.2 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#4] prototype.html Cycles:180 Average:4042.12 Median:4464.25 stddev:1171.74 (26.2%) stddev-sans-first:1140.60 13:28:00 INFO - PROCESS | 3368 | Values: 285.7 293.5 296.6 301.7 302.9 4579.9 4775.5 4813.8 4820.3 4837.9 4615.8 4730.8 4768.0 4803.3 4804.9 3778.4 3779.9 3789.5 3792.2 3797.2 3561.1 3612.9 3765.3 3770.4 3806.8 3737.6 3738.0 3738.4 3742.5 3763.3 3727.9 3730.4 3732.2 3736.3 3739.9 3293.2 3295.2 3298.2 3299.9 3303.1 4549.1 4654.7 4669.2 4677.5 4710.6 4256.8 4264.7 4279.0 4283.7 4288.5 4979.3 4993.4 5005.3 5017.3 5019.6 3366.3 3453.3 3477.7 3482.4 3494.9 5197.8 5229.3 5233.5 5235.3 5249.1 3583.7 3587.8 3593.7 3595.4 3634.6 3442.3 3590.8 3675.3 3675.4 3677.6 4166.3 4175.5 4175.8 4179.0 4202.3 5033.2 5034.3 5055.4 5108.4 5108.5 1220.9 1246.3 1258.8 1268.4 1268.4 850.6 876.0 879.2 883.1 883.2 4458.0 4462.3 4479.2 4487.6 4495.8 5125.1 5165.1 5165.8 5203.9 5206.0 4351.1 4403.9 4447.7 4466.2 4500.4 2442.3 2459.2 2462.2 2476.4 2493.0 4330.5 4334.5 4348.8 4353.3 4390.7 4478.8 4638.7 4669.7 4672.3 4692.7 4251.7 4295.3 4307.6 4308.6 4346.8 4555.4 4557.5 4589.0 4609.5 4618.4 4299.3 4471.1 4490.4 4505.6 4548.0 4295.5 4314.8 4327.2 4349.7 4362.4 3344.4 3353.5 3357.9 3358.6 3367.4 4592.6 4603.6 4603.9 4625.6 4630.3 4722.8 5058.3 5062.4 5067.3 5076.0 5043.9 5048.6 5072.8 5084.9 5123.4 4597.8 4786.2 5006.3 5014.5 5051.2 5101.6 5104.5 5111.5 5113.6 5123.5 4976.1 4976.3 4986.7 5003.1 5007.2 13:28:00 INFO - PROCESS | 3368 | 13:28:00 INFO - PROCESS | 3368 | [#5] yui.html Cycles:180 Average:15912.67 Median:486.16 stddev:22178.34 (4562.0%) stddev-sans-first:22210.75 13:28:00 INFO - PROCESS | 3368 | Values: 600.1 611.4 627.4 682.0 702.4 11719.5 11931.6 12389.9 12446.2 12652.9 12009.8 12103.3 12105.9 12134.6 12175.6 624.4 738.2 749.9 750.8 751.1 635.2 748.7 756.4 769.1 773.1 810.6 812.5 814.0 814.1 814.1 649.4 806.4 807.3 807.5 807.9 570.4 573.3 584.9 586.1 587.1 11972.5 11993.1 11995.3 11995.8 12038.3 11140.5 11486.8 11597.1 11684.8 11780.5 11499.6 11547.2 11796.8 11864.7 11987.3 4089.9 4104.1 4111.1 4243.7 4251.7 59843.7 60778.4 61455.0 61538.7 62066.7 9189.5 9227.3 9351.8 9449.0 9482.7 17396.1 17404.5 17429.2 17449.7 17449.8 6476.3 6486.9 6490.2 6490.3 6494.3 3487.4 3623.0 3625.2 3686.7 3704.2 2617.1 2693.2 2705.6 2711.8 2717.2 464.5 481.1 485.9 486.5 493.6 526.4 549.9 553.9 554.9 565.5 6815.8 6866.6 7013.9 7466.3 7756.5 412.4 487.3 526.9 540.6 544.2 3459.5 3545.1 3627.2 3665.3 3704.0 79126.6 81657.0 82109.2 92513.5 96320.0 48142.5 55237.7 77730.2 80800.6 82327.0 71910.0 73312.6 73682.0 74393.6 74462.6 8130.7 8470.7 8586.1 8611.9 8798.1 30322.7 31518.0 31676.4 42225.8 42237.2 38745.8 40034.4 40046.6 40487.6 41516.6 11159.8 11329.8 11566.2 11675.0 12074.7 12662.7 12702.9 12952.0 12975.5 13331.2 11421.2 11438.4 11753.4 12183.5 12217.6 11754.3 11848.1 12164.9 12363.5 12519.1 10895.6 11087.6 11261.5 11546.1 11905.7 9129.6 9593.6 9621.7 9704.8 10128.9 8775.1 9021.0 9437.4 9797.8 9816.4 13:28:00 INFO - PROCESS | 3368 | -------- Summary: end -------- 13:28:00 INFO - PROCESS | 3368 | 13:28:01 INFO - TEST-INFO | 3368: exit 0 13:28:01 INFO - TEST-OK | dromaeo_css | took 1124475ms 13:28:01 INFO - TEST-START | kraken 13:28:01 INFO - operating with platform_type : linux_ 13:28:01 INFO - Initialising browser for kraken test... 13:28:01 INFO - TEST-INFO | started process 3559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcjLoB/profile http://localhost:37171/getInfo.html) 13:28:05 INFO - PROCESS | 3559 | JavaScript error: , line 0: uncaught exception: undefined 13:28:06 INFO - PROCESS | 3559 | __metrics Screen width/height:1600/1200 13:28:06 INFO - PROCESS | 3559 | colorDepth:24 13:28:06 INFO - PROCESS | 3559 | Browser inner width/height: 1024/697 13:28:06 INFO - PROCESS | 3559 | __metrics 13:28:07 INFO - PROCESS | 3559 | 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" 13:28:07 INFO - PROCESS | 3559 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:08 INFO - TEST-INFO | 3559: exit 0 13:28:08 INFO - Browser initialized. 13:28:08 INFO - Running cycle 1/1 for kraken test... 13:28:08 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcjLoB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:20 INFO - PROCESS | 3640 | RSS: Main: 158990336 13:28:20 INFO - PROCESS | 3640 | 13:28:23 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37171/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:24 INFO - PROCESS | 3640 | RSS: Main: 215969792 13:28:24 INFO - PROCESS | 3640 | 13:28:26 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37171/tests/kraken/driver.html?testName=audio-dft) 13:28:27 INFO - PROCESS | 3640 | RSS: Main: 193130496 13:28:27 INFO - PROCESS | 3640 | 13:28:30 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37171/tests/kraken/driver.html?testName=audio-fft) 13:28:31 INFO - PROCESS | 3640 | RSS: Main: 272400384 13:28:31 INFO - PROCESS | 3640 | 13:28:33 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37171/tests/kraken/driver.html?testName=audio-oscillator) 13:28:34 INFO - PROCESS | 3640 | RSS: Main: 181719040 13:28:34 INFO - PROCESS | 3640 | 13:28:36 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:36 INFO - PROCESS | 3640 | RSS: Main: 186933248 13:28:36 INFO - PROCESS | 3640 | 13:28:40 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37171/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:40 INFO - PROCESS | 3640 | RSS: Main: 223182848 13:28:40 INFO - PROCESS | 3640 | 13:28:44 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37171/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:44 INFO - PROCESS | 3640 | RSS: Main: 222629888 13:28:44 INFO - PROCESS | 3640 | 13:28:47 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37171/tests/kraken/driver.html?testName=json-parse-financial) 13:28:48 INFO - PROCESS | 3640 | RSS: Main: 222040064 13:28:48 INFO - PROCESS | 3640 | 13:28:50 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:50 INFO - PROCESS | 3640 | RSS: Main: 186998784 13:28:50 INFO - PROCESS | 3640 | 13:28:52 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:53 INFO - PROCESS | 3640 | RSS: Main: 192253952 13:28:53 INFO - PROCESS | 3640 | 13:28:55 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:56 INFO - PROCESS | 3640 | RSS: Main: 196599808 13:28:56 INFO - PROCESS | 3640 | 13:29:00 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:00 INFO - PROCESS | 3640 | RSS: Main: 191913984 13:29:00 INFO - PROCESS | 3640 | 13:29:03 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:04 INFO - PROCESS | 3640 | RSS: Main: 195530752 13:29:04 INFO - PROCESS | 3640 | 13:29:05 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:37171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37171/tests/kraken/driver.html?testName=ai-astar) 13:29:06 INFO - PROCESS | 3640 | RSS: Main: 247365632 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | __start_tp_report 13:29:06 INFO - PROCESS | 3640 | _x_x_mozilla_page_load 13:29:06 INFO - PROCESS | 3640 | _x_x_mozilla_page_load_details 13:29:06 INFO - PROCESS | 3640 | |i|pagename|runs| 13:29:06 INFO - PROCESS | 3640 | |0;ai-astar;105;114;112;113;113;113;112;113;113;112 13:29:06 INFO - PROCESS | 3640 | |1;audio-beat-detection;157;126;133;194;128;127;150;122;158;120 13:29:06 INFO - PROCESS | 3640 | |2;audio-dft;161;161;160;163;160;162;159;160;161;161 13:29:06 INFO - PROCESS | 3640 | |3;audio-fft;76;74;75;119;74;76;75;74;103;75 13:29:06 INFO - PROCESS | 3640 | |4;audio-oscillator;88;85;119;85;86;86;113;85;85;128 13:29:06 INFO - PROCESS | 3640 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;117;117;116 13:29:06 INFO - PROCESS | 3640 | |6;imaging-darkroom;147;145;146;146;147;146;146;148;146;146 13:29:06 INFO - PROCESS | 3640 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;96;95 13:29:06 INFO - PROCESS | 3640 | |8;json-parse-financial;62;62;62;61;63;63;61;61;61;62 13:29:06 INFO - PROCESS | 3640 | |9;json-stringify-tinderbox;67;66;66;65;65;66;66;66;67;66 13:29:06 INFO - PROCESS | 3640 | |10;stanford-crypto-aes;80;81;89;82;85;89;82;80;79;79 13:29:06 INFO - PROCESS | 3640 | |11;stanford-crypto-ccm;141;133;133;134;138;139;129;131;206;132 13:29:06 INFO - PROCESS | 3640 | |12;stanford-crypto-pbkdf2;168;167;167;168;168;169;163;167;167;166 13:29:06 INFO - PROCESS | 3640 | |13;stanford-crypto-sha256-iterative;67;68;68;66;67;68;66;67;66;66 13:29:06 INFO - PROCESS | 3640 | __end_tp_report 13:29:06 INFO - PROCESS | 3640 | __start_cc_report 13:29:06 INFO - PROCESS | 3640 | _x_x_mozilla_cycle_collect,1931 13:29:06 INFO - PROCESS | 3640 | __end_cc_report 13:29:06 INFO - PROCESS | 3640 | __startTimestamp1469651346220__endTimestamp 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | ------- Summary: start ------- 13:29:06 INFO - PROCESS | 3640 | Number of tests: 14 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.54 (2.2%) stddev-sans-first:0.67 13:29:06 INFO - PROCESS | 3640 | Values: 105.0 114.0 112.0 113.0 113.0 113.0 112.0 113.0 113.0 112.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:141.50 stddev:23.31 (16.5%) stddev-sans-first:24.04 13:29:06 INFO - PROCESS | 3640 | Values: 157.0 126.0 133.0 194.0 128.0 127.0 150.0 122.0 158.0 120.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 13:29:06 INFO - PROCESS | 3640 | Values: 161.0 161.0 160.0 163.0 160.0 162.0 159.0 160.0 161.0 161.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:15.71 (20.9%) stddev-sans-first:16.51 13:29:06 INFO - PROCESS | 3640 | Values: 76.0 74.0 75.0 119.0 74.0 76.0 75.0 74.0 103.0 75.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:16.96 (20.0%) stddev-sans-first:17.74 13:29:06 INFO - PROCESS | 3640 | Values: 88.0 85.0 119.0 85.0 86.0 86.0 113.0 85.0 85.0 128.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:29:06 INFO - PROCESS | 3640 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 13:29:06 INFO - PROCESS | 3640 | Values: 147.0 145.0 146.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:29:06 INFO - PROCESS | 3640 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 13:29:06 INFO - PROCESS | 3640 | Values: 62.0 62.0 62.0 61.0 63.0 63.0 61.0 61.0 61.0 62.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 13:29:06 INFO - PROCESS | 3640 | Values: 67.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 67.0 66.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.81 (4.6%) stddev-sans-first:3.92 13:29:06 INFO - PROCESS | 3640 | Values: 80.0 81.0 89.0 82.0 85.0 89.0 82.0 80.0 79.0 79.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:136.00 stddev:22.94 (16.9%) stddev-sans-first:24.33 13:29:06 INFO - PROCESS | 3640 | Values: 141.0 133.0 133.0 134.0 138.0 139.0 129.0 131.0 206.0 132.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 13:29:06 INFO - PROCESS | 3640 | Values: 168.0 167.0 167.0 168.0 168.0 169.0 163.0 167.0 167.0 166.0 13:29:06 INFO - PROCESS | 3640 | 13:29:06 INFO - PROCESS | 3640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 13:29:06 INFO - PROCESS | 3640 | Values: 67.0 68.0 68.0 66.0 67.0 68.0 66.0 67.0 66.0 66.0 13:29:06 INFO - PROCESS | 3640 | -------- Summary: end -------- 13:29:06 INFO - PROCESS | 3640 | 13:29:07 INFO - TEST-INFO | 3640: exit 0 13:29:07 INFO - TEST-OK | kraken | took 66306ms 13:29:07 INFO - SUITE-END | took 1190s 13:29:07 INFO - Completed test suite (00:19:50) 13:29:07 INFO - javascript benchmark 13:29:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.491734111849, 2608.413107050914, 2637.7494138056877, 2643.2863126955713, 2650.297671117153, 4560.2019646561885, 4644.442666879971, 4717.245240761479, 4727.574518293353, 4727.739974301417, 4712.811487540503, 4717.78769955352, 4775.212090005154, 4792.448868380137, 4825.71045737256, 4293.65650747941, 4327.675424343187, 4396.098799746044, 4444.97777511112, 4518.231900576893, 4443.333499974998, 4473.843415480459, 4479.104179164164, 4495.078508905683, 4512.932306015412, 4224.493060832689, 4305.720128191658, 4323.286657701476, 4360.389545463638, 4386.166628340637, 4336.718113322656, 4342.196693611692, 4386.758728269944, 4406.889827754332, 4412.624926881219, 4345.087531618364, 4358.411614432042, 4364.236258654754, 4394.60448559628, 4413.360062790877, 4631.490536041033, 4672.3692301539195, 4749.620030397595, 4764.595009424203, 4799.712017278975, 5046.747662616891, 5081.339425874613, 5082.644214904958, 5083.949160508385, 5107.055194788939, 5111.488851114858, 5126.666766660155, 5131.743412829381, 5162.303089082963, 5174.508421699932, 4631.050634619928, 4774.427068751772, 4842.249451334978, 4848.0788650156355, 4898.485659005753, 5321.547668448148, 5370.087085195526, 5378.542823859937, 5379.78480860769, 5381.623286369917, 5112.897742045213, 5129.846104616868, 5148.613853960968, 5150.098732721759, 5153.4073581538605, 4898.853034408973, 5004.374453193351, 5027.1705168647495, 5038.521340472649, 5116.667416617908, 5015.4733752956145, 5025.0, 5026.447090820006, 5029.346184995927, 5085.1355269604255, 4985.52637499437, 4987.4015118185325, 4989.12690279207, 4989.775460104304, 5038.84883453497, 4184.476940382452, 4213.220554197484, 4216.494020717533, 4268.509121451011, 4269.295566231599, 3728.8694895678523, 3737.2338670572467, 3770.981145094312, 3772.679322257584, 3774.094217387862, 4304.698671092993, 4362.498312694081, 4404.295312749945, 4414.227510185769, 4463.285874260103, 5053.191489361758, 5063.3923929128005, 5070.847874563769, 5078.085944529947, 5127.282180494733, 4360.106178233518, 4362.476502819682, 4369.9126017479475, 4402.843813810727, 4416.514183439819, 4449.0, 4511.097780443924, 4517.796699148546, 4552.795124219418, 4563.566461186182, 4738.005018945991, 4740.265258884879, 4743.980044290494, 4747.145513807548, 4794.376731024944, 5027.64806463544, 5041.193409054534, 5044.672096313728, 5092.363454568179, 5124.333836601218, 4647.721136731807, 4671.556202160925, 4672.065586882569, 4704.059188162313, 4769.66612337133, 4936.03747269279, 4940.061388336205, 4944.417449251918, 4948.985457981177, 4984.925226121683, 4987.426445958761, 4989.900201996013, 5012.223105418666, 5017.1721665924715, 5039.84880453587, 4809.2305231162845, 4945.925811112908, 4961.776720047535, 4963.156263435152, 5037.244413337882, 4963.5780958618925, 4964.627652925973, 4969.055879382906, 4971.527704868032, 5022.0960227158, 4896.632752543503, 4900.2894580286375, 4956.330895329084, 4966.478519755518, 4981.277714731416, 4847.054824309226, 4919.942212424203, 4971.328870602567, 4976.0, 5014.07239660664, 4856.805727770849, 4874.488178741323, 4874.634402419903, 4875.829345972874, 4928.778204980713], "value": 4659.579521284407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.0, 582.4437662032758, 582.4466756581248, 590.5688847141587, 596.0284735880514, 27063.0, 38861.61138388615, 40172.59827401725, 40184.79907600458, 44048.11903761931, 39658.40512392309, 39985.200295994066, 40042.0, 40171.0, 40313.7984310078, 7555.84888302235, 7753.728619498319, 7774.494657847222, 7781.41639377049, 7788.14330423653, 7347.191808901017, 9556.283278754086, 9780.559874805615, 9799.16707079899, 10178.44018578978, 9935.105840474356, 10009.0, 10026.39841609502, 10037.146842518394, 10039.69880903574, 9546.522673866313, 9607.327487075907, 9607.90392096077, 9614.134727874525, 9619.663311784088, 9665.516724163763, 9729.464879431629, 9730.805383892353, 9734.610615575368, 9734.707958761248, 37961.0, 38246.42630360547, 38306.0, 38317.61682383168, 38321.23357532862, 2765.198092553157, 2888.6244788177614, 2942.3085574889883, 3036.5445183222473, 3268.9866141495972, 29176.270593235127, 29776.404471910657, 29865.55201671977, 30097.699023009707, 30343.089707308816, 2961.304093538038, 2974.152366575537, 3053.0, 3053.3130045739754, 3123.375324935022, 255742.0, 255933.0, 256832.99999999814, 256930.0, 257963.0, 31151.22121946924, 52037.47962520326, 52337.7383113082, 52342.691432714484, 52436.21345679818, 31173.688263117532, 33230.66769332276, 33305.0, 33345.333093338, 33345.333093338486, 12697.55558555446, 12805.487780488862, 12857.614271571867, 12859.16415432994, 12859.357032148355, 9429.868415790012, 9575.377600456088, 10022.398656080659, 10118.949405252926, 10122.240831937634, 7346.33882950537, 7399.963000184965, 7547.622618869034, 7787.493812902143, 7818.92181078182, 3032.378362435695, 3133.310671652233, 3139.7174254316765, 3176.857041433141, 3181.729552988022, 874.0691163910415, 884.4030279561271, 893.1247377570018, 900.1268769293774, 904.5884122724144, 27677.0, 28367.89504687557, 28558.857205713837, 28795.424091518053, 29204.415911681648, 949.6581230756922, 960.6493629825063, 986.1174249047062, 992.374803873555, 1085.973754801705, 14920.40318387274, 15062.774058389134, 15132.924335378253, 15541.689166216613, 15573.14347710864, 398820.0, 402362.0, 402393.832431727, 402831.0, 402940.0, 48039.75980120147, 48508.514914851105, 48631.5136848627, 48701.51298487041, 48723.75638121787, 1173.8532683414574, 1197.6167626359656, 1212.8241404996227, 1218.65268398506, 1222.3093951917137, 25391.61912571276, 27257.86371068132, 27588.517033467084, 27687.58468622932, 27974.58038129389, 37149.628503714615, 41365.37951930663, 41582.79208603938, 41605.1678966425, 41611.7919410401, 327320.0, 330672.5861043197, 330857.0, 331086.0, 331893.0, 21872.89063554672, 24308.75691243065, 24828.255152345457, 24857.627135593342, 25185.62221566641, 40689.1862162761, 40982.38526422166, 41078.79460602678, 41677.79161104175, 41988.790056049525, 34565.82717086399, 34927.0, 35050.82474587611, 35136.82431587826, 35439.46840797442, 34447.31105377928, 34903.12742181466, 35281.82359088188, 35452.64547354494, 35632.28735425329, 34707.82646086753, 35126.0, 35318.64681353154, 35597.82201088978, 35757.82121089378, 30048.24879378033, 32622.184445389055, 32655.18362040873, 32779.0, 32940.0, 24630.753692462848, 25097.49805003853, 25198.496030078928, 25311.114111006027, 25638.743612563634], "value": 16623.045670652788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.7174032514313, 359.91901822090034, 367.36079222153455, 376.4804569693822, 381.38483522283144, 15899.920500397497, 16715.916420417896, 17373.0, 17424.041677707723, 17462.738058929128, 15063.096214227155, 15897.205139742995, 15937.362505499796, 15995.680086398264, 16020.519384418458, 4871.683340582859, 5107.8467645970495, 5118.334616499868, 5118.897622047557, 5122.641415100945, 3740.36413809653, 3882.1265215326466, 5037.017781532602, 5518.889622207574, 5755.65466072037, 5834.941650583482, 5840.182374467578, 5846.50304724099, 5847.006008978463, 5852.063669812831, 5649.717514124298, 5947.910781338283, 5957.136215248808, 5965.880682386328, 5968.134620480006, 5027.949720502785, 5225.294585231021, 5226.660267082628, 5239.528442440199, 5241.895162096736, 16975.91512042444, 16987.3205071797, 17188.828111718973, 17195.828041719673, 17261.223244954006, 1995.6607376745987, 2067.6795096760025, 2107.9262225822176, 2366.7041619797524, 2440.9145679901117, 13397.799033014513, 13452.663683407894, 13548.390322435514, 13553.186808791505, 14070.718585628332, 1727.7322015087557, 1801.927922883083, 1845.308009496439, 1862.8695991280615, 1876.5496280892487, 71543.2845671547, 72291.27708722898, 72336.0, 73113.0, 73457.0, 9637.22902167825, 9777.804443911082, 9872.802543949081, 10040.899591004143, 10104.747381315527, 13310.600681979557, 13386.062975591614, 13388.06283560161, 13392.933035334761, 13398.531051413154, 6870.725170993204, 7258.383037441771, 7271.272872712792, 7365.0, 7382.18795932447, 6932.202796678446, 6932.410745086724, 7127.8574428512175, 7154.964225178945, 7167.569945803269, 4114.300568903293, 4235.555266697014, 4236.809343579484, 4337.696361254745, 4340.739555626609, 1640.409452597064, 1672.3728601774335, 1698.4989428118736, 1703.3271857616173, 1718.707819670659, 876.6756300168978, 893.6425429828121, 901.9819603607891, 913.981720365589, 933.2580598424133, 15561.766573501407, 16699.0, 17029.40397086096, 17240.568985775204, 17689.20398582067, 828.362161135922, 839.689314953459, 849.8980122385353, 872.6465781358434, 907.2832462354665, 9094.226990705733, 9794.902050979541, 9855.55649995752, 9868.654597089067, 9971.202303815677, 425362.0, 430623.0, 434868.0, 437774.0, 439292.0, 77075.0, 78919.0, 80438.0, 81623.59188204021, 82308.0, 818.378032695144, 860.7589874835056, 866.9046404895456, 889.3952112563519, 890.1499068389672, 15084.86863485221, 15854.52436426863, 15972.68054638924, 16312.429064982669, 16538.917305413397, 37723.81138094292, 38128.80935595415, 38407.0, 39963.40054899121, 40551.59448405478, 51851.2222316658, 52741.0, 53309.7334513325, 53402.0, 54350.7282463601, 6490.221173459215, 7146.3568278855155, 7252.818679533054, 7498.08112122328, 7527.397808175223, 9786.892679013774, 11077.833832492357, 12251.326177060348, 12256.877431225574, 12427.19805628197, 10577.100946419641, 10593.152547796311, 10721.892781072402, 10942.0, 10990.17573681993, 10705.89294107049, 10711.839322410015, 10841.67474975752, 10863.837042444211, 10978.780424391627, 10684.145268378667, 10771.246012779031, 10800.135989120694, 11070.169737269576, 11222.10223182127, 6835.179778426621, 6919.861602768017, 7001.754938577125, 7004.579725216503, 7052.682629281592, 10711.0, 10732.46337683097, 10803.783924321313, 10813.62152324665, 11242.606508772154], "value": 8335.21834765003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.2128144394808, 1385.8891288696905, 1425.9714805703886, 1657.668466306739, 1693.8306169383063, 7209.315115064067, 7755.806104847382, 7761.0, 7763.573003484806, 7766.378689704824, 6445.677716114187, 6650.800475985716, 6653.900191497131, 6852.6231057291825, 7622.199669034755, 1892.1107079672565, 2072.616565935307, 2153.924612638558, 2155.2241193170526, 2175.967360489594, 2170.8263338932925, 2171.815395691368, 2189.967150492736, 2191.561687662466, 2195.2316689158824, 2088.4256829371893, 2165.8700477971292, 2168.642174041281, 2169.4142581503065, 2170.0885628036262, 2149.720536330283, 2155.3749412670386, 2158.2554018863466, 2187.9453013674624, 2192.7478339990944, 2117.7776333484917, 2127.968080478794, 2148.6562150055915, 2150.806427421524, 2152.5802468518646, 7746.070471543395, 7820.45256832022, 7831.765047048598, 7832.686692532349, 7838.960805195995, 4338.305871060616, 4408.338749187616, 4424.336349547561, 4470.173017991649, 4479.888002799924, 2681.276055465033, 2780.624615676878, 2845.530487469565, 2854.1865568312933, 2860.7139286071433, 875.2123089219754, 878.5255961780631, 889.8665200220019, 900.8333458310234, 908.2098574240453, 10356.533955972, 10388.896111038868, 10400.94799526005, 10405.635802746943, 10431.79136417275, 3826.5025546678753, 4043.959560404417, 4186.267403204427, 4193.91612167761, 4196.727212731163, 8893.155150260714, 8907.955460222787, 8909.465432074096, 8933.374663773473, 8943.552822358986, 4212.136512015091, 4217.030083080908, 4219.746815191098, 4221.303484924953, 4239.533651298355, 3734.178480734234, 3735.7758534488016, 3737.6075512071384, 3739.9439008414897, 3745.5318085239346, 3263.2494526259093, 3379.273456206927, 3395.37185620656, 3452.016175390052, 3520.894373168809, 968.1045033344128, 988.1353815411514, 988.268681175939, 989.5349185882624, 998.5257002923698, 765.1812560560259, 827.4249396669258, 836.2306677856386, 836.3768992100923, 843.5360551696542, 4959.553640172402, 5034.270030845581, 5069.467705890902, 5137.357830271216, 5329.786808527693, 804.5534728225774, 811.7645882694071, 834.6536187482249, 881.167296904432, 908.3596064774318, 3441.483777433405, 3474.8957531274104, 3546.414841551167, 3592.604813470516, 3617.5478065241846, 9114.817703646022, 9600.567974441166, 9600.75998100039, 9609.663661771805, 9627.277954153467, 9447.244220462346, 9470.14768670823, 9532.094451027142, 9544.141027307576, 9557.713268601952, 7143.4999550031, 7210.459215558854, 7357.963210184022, 7373.262673732584, 7375.299346562068, 4979.477154898684, 5028.723420211923, 5099.87250318745, 5147.485251474973, 5219.086659834438, 8612.138786121337, 8776.473411595325, 8798.516081615573, 8827.337949653931, 8864.911350886408, 8783.912160878564, 8877.778055548404, 9088.409253398508, 9127.954360228156, 9133.315001375056, 5296.126139186991, 5704.743286552032, 5967.164596956342, 6041.456268935817, 6046.123312119806, 6773.0, 6988.091548098715, 7006.579605223703, 7012.403945664676, 7026.367626913602, 6379.553431259767, 6385.233771947396, 6390.968045159744, 6451.548391612542, 6487.643179625166, 6280.685965701605, 6329.145565348619, 6392.904106438315, 6397.552171347961, 6453.193350831146, 5636.943630563642, 5716.142578613241, 5726.4273572642405, 5728.455796699307, 5729.742161602655, 4172.770497622539, 4180.937285940774, 4194.958050419456, 4235.682323825787, 4249.235137675249, 4439.334099885043, 4520.502744698147, 4549.886252843706, 4650.255959046536, 4727.220008698526], "value": 3975.390327702748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7371218478998, 293.520094645255, 296.55368670151444, 301.7163865965992, 302.9015569939769, 4579.908401831962, 4775.546323099305, 4813.759312034402, 4820.25286080658, 4837.863102170992, 4615.8153673853, 4730.810767569302, 4768.0, 4803.279508073791, 4804.90390192196, 3778.414345776409, 3779.924401511968, 3789.450529673196, 3792.2036372361836, 3797.164623782777, 3561.1240662424507, 3612.9277414451694, 3765.3034188675047, 3770.4344348347695, 3806.7525610835346, 3737.6075512071247, 3737.9813100934457, 3738.439234114891, 3742.4760533525327, 3763.3468404774567, 3727.8881633551036, 3730.3658378075656, 3732.197577520819, 3736.2527494500937, 3739.8967304645194, 3293.1602441377536, 3295.1597342677705, 3298.191942973963, 3299.9110293603053, 3303.0916497963253, 4549.067441174584, 4654.650901182425, 4669.182892993713, 4677.497538816717, 4710.646701497401, 4256.765877876715, 4264.701470897038, 4278.957210427887, 4283.678724095674, 4288.506821715511, 4979.253112033188, 4993.375828021497, 5005.324281222025, 5017.322661440695, 5019.598432125421, 3366.309906469168, 3453.2920751245933, 3477.7217822574385, 3482.4253998090285, 3494.8776792812127, 5197.752539390519, 5229.294045303874, 5233.450487698813, 5235.319408476912, 5249.081410753103, 3583.6595523425235, 3587.7847329160336, 3593.7484376093944, 3595.3528364894046, 3634.582023067381, 3442.2599141184264, 3590.8204589770407, 3675.2649470106085, 3675.3568125577917, 3677.558692956862, 4166.270902592034, 4175.519815221228, 4175.770332631734, 4179.0, 4202.285611446062, 5033.194688849767, 5034.295198672189, 5055.418626857959, 5108.386993560796, 5108.463611320833, 1220.9389530523615, 1246.2771592476342, 1258.8237646729465, 1268.3594784633701, 1268.4101892619792, 850.6427300533791, 875.9737207883646, 879.1999280654574, 883.1433509495779, 883.2007033634571, 4458.0, 4462.308342206963, 4479.17135329965, 4487.573680500347, 4495.775211239425, 5125.103106956268, 5165.070287348313, 5165.793368265227, 5203.947960520346, 5205.973970130125, 4351.108022855307, 4403.889902752393, 4447.666425018137, 4466.196084704719, 4500.437445319335, 2442.3283597010964, 2459.2007597530874, 2462.1997850698594, 2476.3809047738064, 2492.9529597569062, 4330.501992270866, 4334.523202447728, 4348.804303806336, 4353.34699795027, 4390.736555806662, 4478.776061196927, 4638.744869032168, 4669.7431641260055, 4672.275797251432, 4692.738546710004, 4251.702380833312, 4295.312749960054, 4307.612314891675, 4308.569143085666, 4346.7609281489185, 4555.3850230218495, 4557.521460246627, 4588.977055114703, 4609.492955774929, 4618.376519169869, 4299.333603291495, 4471.128130014616, 4490.438695163105, 4505.61702255312, 4547.976150612945, 4295.548967358507, 4314.827406903689, 4327.242732521733, 4349.652027837828, 4362.3892655027685, 3344.357957213871, 3353.5472711184652, 3357.867753976194, 3358.639750900889, 3367.3602015616952, 4592.632589392907, 4603.631709463168, 4603.907921841612, 4625.629949603956, 4630.305454181899, 4722.787474563722, 5058.266551350107, 5062.443131255485, 5067.2652465391575, 5075.974620126875, 5043.9243411348125, 5048.64659473848, 5072.847814565569, 5084.872878178076, 5123.38519377677, 4597.793099310472, 4786.234202527578, 5006.349174607278, 5014.545781723259, 5051.2423136529815, 5101.642884998015, 5104.540591346797, 5111.4888511150075, 5113.616478764182, 5123.487651234846, 4976.129177394014, 4976.253561965734, 4986.7283842621355, 5003.124453220745, 5007.223880298559], "value": 3675.355434952936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1208229943135, 611.3550204534216, 627.3820287017287, 681.9897701534475, 702.4310308649993, 11719.53121875125, 11931.64205073847, 12389.876101238984, 12446.19099758515, 12652.936735316322, 12009.819852702216, 12103.27380357177, 12105.878941210585, 12134.575289864857, 12175.57385491508, 624.3818619566619, 738.1511262048647, 749.9325060744532, 750.7560042986024, 751.0611735330837, 635.209164590086, 748.7304570354668, 756.4062211164237, 769.1116760142017, 773.0607312115778, 810.5947026486757, 812.4962523235603, 813.979650508739, 814.0638265994095, 814.0882211922655, 649.3538928765909, 806.3871457692137, 807.3420162567488, 807.4912804932914, 807.8505476486839, 570.3640440908357, 573.2833957553058, 584.8684046089638, 586.1178925716812, 587.1369087441454, 11972.521099156023, 11993.100517461138, 11995.28028318295, 11995.760084798343, 12038.33789141597, 11140.498677559448, 11486.770264594661, 11597.13021523389, 11684.824727629093, 11780.469878855472, 11499.576672144976, 11547.191696581243, 11796.764064718658, 11864.703382415422, 11987.280763154151, 4089.8568550100604, 4104.056067104582, 4111.09555897702, 4243.702940794145, 4251.681123915719, 59843.70078149625, 60778.392216077715, 61455.0, 61538.69230653863, 62066.68966655138, 9189.494577798152, 9227.307951903635, 9351.766205844908, 9449.0, 9482.715518534455, 17396.130193490273, 17404.477865664052, 17429.21568529419, 17449.651006979788, 17449.82550174482, 6476.319986401454, 6486.902696459557, 6490.188726409199, 6490.318516555693, 6494.318096599884, 3487.3722729908354, 3622.9637703622625, 3625.220577575834, 3686.7419280650633, 3704.2221133561716, 2617.1101825379465, 2693.165118813174, 2705.580635001578, 2711.796615253864, 2717.2120085175475, 464.4612249790227, 481.12435367630576, 485.861529464101, 486.4527406667499, 493.6001838510818, 526.4419715102005, 549.884524249904, 553.8615346163459, 554.9372950799255, 565.5193085876972, 6815.829604259933, 6866.622335771581, 7013.929860701328, 7466.290702383265, 7756.534607923542, 412.38966329832016, 487.3080226078976, 526.9104252277122, 540.6242661350402, 544.1864412703035, 3459.498372735939, 3545.06055895188, 3627.2020155565733, 3665.2852693725, 3703.981480092636, 79126.6043669778, 81657.0, 82109.17890821135, 92513.53743231241, 96320.0, 48142.5185748145, 55237.72381138069, 77730.22269777342, 80800.59599701964, 82327.0, 71909.99999999895, 73312.63343683354, 73682.0, 74393.62803186057, 74462.6276868623, 8130.67477300925, 8470.661173553235, 8586.141385861614, 8611.913880861362, 8798.12018798115, 30322.69677303199, 31518.0, 31676.366472670878, 42225.78887105545, 42237.155256894075, 38745.806270969595, 40034.39948400718, 40046.59953400429, 40487.595124048385, 41516.58483415127, 11159.81589591346, 11329.773404532029, 11566.248193867708, 11675.0, 12074.698132546757, 12662.746745065231, 12702.87297127017, 12952.0, 12975.545855894998, 13331.200127992352, 11421.200515964136, 11438.370889601152, 11753.353565553976, 12183.451744671334, 12217.633470995885, 11754.29474231549, 11848.111391645489, 12164.878351216375, 12363.505459781509, 12519.061070419937, 10895.618653347095, 11087.611933582608, 11261.549538018387, 11546.0763138947, 11905.702357440787, 9129.589168487566, 9593.568289426852, 9621.663241786504, 9704.75738106553, 10128.949355253177, 8775.122487751174, 9020.954895225745, 9437.386569873212, 9797.804043918939, 9816.422996592157], "value": 6192.6406960034965, "unit": "score"}], "name": "dromaeo_css", "value": 6229.167257947397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 133.0, 194.0, 128.0, 127.0, 150.0, 122.0, 158.0, 120.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 163.0, 160.0, 162.0, 159.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 119.0, 74.0, 76.0, 75.0, 74.0, 103.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 119.0, 85.0, 86.0, 86.0, 113.0, 85.0, 85.0, 128.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 63.0, 61.0, 61.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 89.0, 82.0, 85.0, 89.0, 82.0, 80.0, 79.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 133.0, 134.0, 138.0, 139.0, 129.0, 131.0, 206.0, 132.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 167.0, 168.0, 168.0, 169.0, 163.0, 167.0, 167.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1536.5, "alertThreshold": 2.0}]} 13:29:07 INFO - Return code: 0 13:29:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:07 INFO - # TBPL SUCCESS # 13:29:07 INFO - Running post-action listener: _resource_record_post_action 13:29:07 INFO - [mozharness: 2016-07-27 20:29:07.530804Z] Finished run-tests step (success) 13:29:07 INFO - Running post-run listener: _resource_record_post_run 13:29:07 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 7815168; Write bytes: 420380672; Read time: 3040; Write time: 825012 13:29:07 INFO - TinderboxPrint: CPU usage
13.1% 13:29:07 INFO - TinderboxPrint: I/O read bytes / time
7,815,168 / 3,040 13:29:07 INFO - TinderboxPrint: I/O write bytes / time
420,380,672 / 825,012 13:29:07 INFO - TinderboxPrint: CPU idle
8,379.2 (86.9%) 13:29:07 INFO - TinderboxPrint: CPU user
1,204.1 (12.5%) 13:29:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 84160512; Read time: 120; Write time: 112848 13:29:07 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5791744; Write bytes: 336220160; Read time: 2684; Write time: 712164 13:29:08 INFO - Running post-run listener: _upload_blobber_files 13:29:08 INFO - Blob upload gear active. 13:29:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:08 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 13:29:08 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'] 13:29:08 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 13:29:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:24 INFO - (blobuploader) - INFO - Done attempting. 13:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:25 INFO - (blobuploader) - INFO - Done attempting. 13:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:25 INFO - (blobuploader) - INFO - Done attempting. 13:29:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:25 INFO - Return code: 0 13:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/47100dd2c39359bb0039a39fee75da79cf8fa87e7318fe72537b825d8dcb5f9280a96b7f6b7d7796039849837a70f3f7d56a190e58f0b215934f0d22b096daab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c071b4a35c6a8a70898b2d5c7265dd4593b06ede2e0caff042cd4f4d289f884d5921e6e2f697489a8d8f543704bf74ca7f7eed403ca766778f8acf7005238659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1ac063ef3aebbfae6ef58f2a21366e535098d3269882c991a700880d9af7ca66cd67bdd224ef065d446559c4658aa3f7b1fdcc5ba2342efbcbb9d6d0f7fe0759"} 13:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:25 INFO - Contents: 13:29:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/47100dd2c39359bb0039a39fee75da79cf8fa87e7318fe72537b825d8dcb5f9280a96b7f6b7d7796039849837a70f3f7d56a190e58f0b215934f0d22b096daab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c071b4a35c6a8a70898b2d5c7265dd4593b06ede2e0caff042cd4f4d289f884d5921e6e2f697489a8d8f543704bf74ca7f7eed403ca766778f8acf7005238659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1ac063ef3aebbfae6ef58f2a21366e535098d3269882c991a700880d9af7ca66cd67bdd224ef065d446559c4658aa3f7b1fdcc5ba2342efbcbb9d6d0f7fe0759"} 13:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:25 INFO - Copying logs to upload dir... 13:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.586365 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-07-27 13:29:25.922503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 13:29:25.927829) ========= 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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 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/47100dd2c39359bb0039a39fee75da79cf8fa87e7318fe72537b825d8dcb5f9280a96b7f6b7d7796039849837a70f3f7d56a190e58f0b215934f0d22b096daab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c071b4a35c6a8a70898b2d5c7265dd4593b06ede2e0caff042cd4f4d289f884d5921e6e2f697489a8d8f543704bf74ca7f7eed403ca766778f8acf7005238659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1ac063ef3aebbfae6ef58f2a21366e535098d3269882c991a700880d9af7ca66cd67bdd224ef065d446559c4658aa3f7b1fdcc5ba2342efbcbb9d6d0f7fe0759"} build_url:https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/UZyw8R1LS7aJirxKkzrUng/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/47100dd2c39359bb0039a39fee75da79cf8fa87e7318fe72537b825d8dcb5f9280a96b7f6b7d7796039849837a70f3f7d56a190e58f0b215934f0d22b096daab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c071b4a35c6a8a70898b2d5c7265dd4593b06ede2e0caff042cd4f4d289f884d5921e6e2f697489a8d8f543704bf74ca7f7eed403ca766778f8acf7005238659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1ac063ef3aebbfae6ef58f2a21366e535098d3269882c991a700880d9af7ca66cd67bdd224ef065d446559c4658aa3f7b1fdcc5ba2342efbcbb9d6d0f7fe0759"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 13:29:25.954207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:29:25.954581) ========= 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=745a4373a2a16df560f216e000000264-1469649532.231578-1874100314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 13:29:26.038128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 13:29:26.038491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 13:29:26.038904) ========= ========= Total master_lag: 0.59 =========