builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1470276007.98 results: success (0) buildid: 20160803173221 builduid: c779c511a2424857b814d73b3e123599 revision: 8538a05d5ba3a006dc77bb85011416f0aa70335c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:07.975875) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:07.976312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:07.976585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:08.161264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:08.161575) ========= 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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 19:00:08-- 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% 104M=0s 2016-08-03 19:00:08 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:08.268408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:08.268721) ========= 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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017826 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:08.317958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 19:00:08.320333) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8538a05d5ba3a006dc77bb85011416f0aa70335c --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 8538a05d5ba3a006dc77bb85011416f0aa70335c --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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 19:00:08,810 truncating revision to first 12 chars 2016-08-03 19:00:08,810 Setting DEBUG logging. 2016-08-03 19:00:08,810 attempt 1/10 2016-08-03 19:00:08,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8538a05d5ba3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 19:00:09,700 unpacking tar archive at: autoland-8538a05d5ba3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.211016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 19:00:09.545325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:09.545654) ========= script_repo_revision: 8538a05d5ba3a006dc77bb85011416f0aa70335c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:09.546047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:09.546325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 19:00:09.559928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 19:00:09.560252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:10 INFO - MultiFileLogger online at 20160803 19:00:10 in /builds/slave/test 19:00:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 19:00:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:10 INFO - {'append_to_log': False, 19:00:10 INFO - 'base_work_dir': '/builds/slave/test', 19:00:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:00:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:10 INFO - 'branch': 'Autoland-Non-PGO', 19:00:10 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:10 INFO - 'config_files': ('talos/linux_config.py',), 19:00:10 INFO - 'default_actions': ('clobber', 19:00:10 INFO - 'read-buildbot-config', 19:00:10 INFO - 'download-and-extract', 19:00:10 INFO - 'populate-webroot', 19:00:10 INFO - 'create-virtualenv', 19:00:10 INFO - 'install', 19:00:10 INFO - 'run-tests'), 19:00:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:10 INFO - 'download_minidump_stackwalk': True, 19:00:10 INFO - 'download_symbols': 'ondemand', 19:00:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:10 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:10 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:10 INFO - 'installer_path': 'installer.exe', 19:00:10 INFO - 'log_level': 'info', 19:00:10 INFO - 'log_name': 'talos', 19:00:10 INFO - 'log_to_console': True, 19:00:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:10 INFO - 'opt_config_files': (), 19:00:10 INFO - 'pip_index': False, 19:00:10 INFO - 'sps_profile': False, 19:00:10 INFO - 'sps_profile_interval': 0, 19:00:10 INFO - 'suite': 'dromaeojs-e10s', 19:00:10 INFO - 'system_bits': '32', 19:00:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:10 INFO - 'title': 'talos-linux64-ix-056', 19:00:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:10 INFO - 'use_talos_json': True, 19:00:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:10 INFO - 'work_dir': 'build'} 19:00:10 INFO - [mozharness: 2016-08-04 02:00:10.146046Z] Running clobber step. 19:00:10 INFO - Running pre-action listener: _resource_record_pre_action 19:00:10 INFO - Running main action method: clobber 19:00:10 INFO - rmtree: /builds/slave/test/build 19:00:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:10 INFO - Running post-action listener: _resource_record_post_action 19:00:10 INFO - [mozharness: 2016-08-04 02:00:10.610270Z] Finished clobber step (success) 19:00:10 INFO - [mozharness: 2016-08-04 02:00:10.610371Z] Running read-buildbot-config step. 19:00:10 INFO - Running pre-action listener: _resource_record_pre_action 19:00:10 INFO - Running main action method: read_buildbot_config 19:00:10 INFO - Using buildbot properties: 19:00:10 INFO - { 19:00:10 INFO - "project": "", 19:00:10 INFO - "product": "firefox", 19:00:10 INFO - "script_repo_revision": "production", 19:00:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 19:00:10 INFO - "repository": "", 19:00:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 19:00:10 INFO - "buildid": "20160803173221", 19:00:10 INFO - "pgo_build": "False", 19:00:10 INFO - "basedir": "/builds/slave/test", 19:00:10 INFO - "buildnumber": 214, 19:00:10 INFO - "slavename": "talos-linux64-ix-056", 19:00:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:00:10 INFO - "platform": "ubuntu64_hw", 19:00:10 INFO - "scheduler": "tests-autoland-linux64-talos", 19:00:10 INFO - "branch": "autoland", 19:00:10 INFO - "repo_path": "integration/autoland", 19:00:10 INFO - "revision": "8538a05d5ba3a006dc77bb85011416f0aa70335c", 19:00:10 INFO - "stage_platform": "linux64", 19:00:10 INFO - "builduid": "c779c511a2424857b814d73b3e123599", 19:00:10 INFO - "slavebuilddir": "test" 19:00:10 INFO - } 19:00:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:00:10 INFO - Running post-action listener: _resource_record_post_action 19:00:10 INFO - [mozharness: 2016-08-04 02:00:10.612827Z] Finished read-buildbot-config step (success) 19:00:10 INFO - [mozharness: 2016-08-04 02:00:10.612917Z] Running download-and-extract step. 19:00:10 INFO - Running pre-action listener: _resource_record_pre_action 19:00:10 INFO - Running main action method: download_and_extract 19:00:10 INFO - mkdir: /builds/slave/test/build/tests 19:00:10 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')]} 19:00:10 INFO - https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:00:11 INFO - Downloaded 1361 bytes. 19:00:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:00:11 INFO - Using the following test package requirements: 19:00:11 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:00:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'jsshell-linux-x86_64.zip'], 19:00:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:11 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:11 INFO - https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:12 INFO - Downloaded 20241031 bytes. 19:00:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:00:13 INFO - Return code: 0 19:00:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:00:13 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')]} 19:00:13 INFO - https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:14 INFO - Downloaded 20241031 bytes. 19:00:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:00:16 INFO - Return code: 0 19:00: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')]} 19:00:16 INFO - https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:00:16 INFO - Downloaded 14413723 bytes. 19:00:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:00:17 INFO - Return code: 0 19:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:17 INFO - https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:00:18 INFO - Downloaded 55566858 bytes. 19:00:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:00:18 INFO - mkdir: /builds/slave/test/properties 19:00:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:18 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:18 INFO - Contents: 19:00:18 INFO - build_url:https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:00:19 INFO - Running post-action listener: _resource_record_post_action 19:00:19 INFO - Running post-action listener: set_extra_try_arguments 19:00:19 INFO - [mozharness: 2016-08-04 02:00:19.185086Z] Finished download-and-extract step (success) 19:00:19 INFO - [mozharness: 2016-08-04 02:00:19.185325Z] Running populate-webroot step. 19:00:19 INFO - Running pre-action listener: _resource_record_pre_action 19:00:19 INFO - Running main action method: populate_webroot 19:00:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:19 INFO - '--tppagecycles', 19:00:19 INFO - '7'], 19:00:19 INFO - 'tests': ['tsvgm']}}, 19:00:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['damp', 'tps']}, 19:00:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['damp', 'tps']}, 19:00:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['dromaeo_dom']}, 19:00:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['basic_compositor_video']}, 19:00:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore', 19:00:19 INFO - 'tabpaint']}, 19:00:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['tsvgx', 19:00:19 INFO - 'tsvgr_opacity', 19:00:19 INFO - 'tart', 19:00:19 INFO - 'tscrollx', 19:00:19 INFO - 'cart']}, 19:00:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:19 INFO - 'tsvgr_opacity', 19:00:19 INFO - 'tart', 19:00:19 INFO - 'tscrollx', 19:00:19 INFO - 'cart']}, 19:00:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--disable-e10s'], 19:00:19 INFO - 'tests': ['tp5o']}, 19:00:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['tp5o']}, 19:00:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--disable-e10s', 19:00:19 INFO - '--xperf_path', 19:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:19 INFO - 'tests': ['tp5n']}, 19:00:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--xperf_path', 19:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:19 INFO - 'tests': ['tp5n']}}, 19:00:19 INFO - 'talos.zip': {'path': '', 19:00:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:19 INFO - Running post-action listener: _resource_record_post_action 19:00:19 INFO - [mozharness: 2016-08-04 02:00:19.201214Z] Finished populate-webroot step (success) 19:00:19 INFO - [mozharness: 2016-08-04 02:00:19.201304Z] Running create-virtualenv step. 19:00:19 INFO - Running pre-action listener: _resource_record_pre_action 19:00:19 INFO - Running main action method: create_virtualenv 19:00:19 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:19 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 19:00:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:19 INFO - Using real prefix '/usr' 19:00:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:21 INFO - Installing pip.................done. 19:00:21 INFO - Return code: 0 19:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:21 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 19:00:21 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 19:00:21 INFO - Using env: {'DISPLAY': ':0', 19:00:21 INFO - 'HOME': '/home/cltbld', 19:00:21 INFO - 'LANG': 'en_US.UTF-8', 19:00:21 INFO - 'LANGUAGE': 'en_US:en', 19:00:21 INFO - 'LOGNAME': 'cltbld', 19:00:21 INFO - 'MAIL': '/var/mail/cltbld', 19:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:21 INFO - 'MOZ_NO_REMOTE': '1', 19:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:21 INFO - 'NO_EM_RESTART': '1', 19:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:21 INFO - 'PWD': '/builds/slave/test', 19:00:21 INFO - 'SHELL': '/bin/bash', 19:00:21 INFO - 'SHLVL': '1', 19:00:21 INFO - 'TERM': 'linux', 19:00:21 INFO - 'TMOUT': '86400', 19:00:21 INFO - 'USER': 'cltbld', 19:00:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:21 INFO - '_': '/tools/buildbot/bin/python'} 19:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:21 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 19:00:21 INFO - Cleaning up... 19:00:22 INFO - Return code: 0 19:00:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:00:22 INFO - Using env: {'DISPLAY': ':0', 19:00:22 INFO - 'HOME': '/home/cltbld', 19:00:22 INFO - 'LANG': 'en_US.UTF-8', 19:00:22 INFO - 'LANGUAGE': 'en_US:en', 19:00:22 INFO - 'LOGNAME': 'cltbld', 19:00:22 INFO - 'MAIL': '/var/mail/cltbld', 19:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:22 INFO - 'MOZ_NO_REMOTE': '1', 19:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:22 INFO - 'NO_EM_RESTART': '1', 19:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:22 INFO - 'PWD': '/builds/slave/test', 19:00:22 INFO - 'SHELL': '/bin/bash', 19:00:22 INFO - 'SHLVL': '1', 19:00:22 INFO - 'TERM': 'linux', 19:00:22 INFO - 'TMOUT': '86400', 19:00:22 INFO - 'USER': 'cltbld', 19:00:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:22 INFO - '_': '/tools/buildbot/bin/python'} 19:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:22 INFO - Downloading/unpacking psutil>=3.1.1 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:24 INFO - Installing collected packages: psutil 19:00:24 INFO - Running setup.py install for psutil 19:00:24 INFO - building 'psutil._psutil_linux' extension 19:00:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:00:24 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 19:00:24 INFO - building 'psutil._psutil_posix' extension 19:00:24 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 19:00:24 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 19:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:24 INFO - Successfully installed psutil 19:00:24 INFO - Cleaning up... 19:00:24 INFO - Return code: 0 19:00:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:24 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 19:00:24 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 19:00:24 INFO - Using env: {'DISPLAY': ':0', 19:00:24 INFO - 'HOME': '/home/cltbld', 19:00:24 INFO - 'LANG': 'en_US.UTF-8', 19:00:24 INFO - 'LANGUAGE': 'en_US:en', 19:00:24 INFO - 'LOGNAME': 'cltbld', 19:00:24 INFO - 'MAIL': '/var/mail/cltbld', 19:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:24 INFO - 'MOZ_NO_REMOTE': '1', 19:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:24 INFO - 'NO_EM_RESTART': '1', 19:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:24 INFO - 'PWD': '/builds/slave/test', 19:00:24 INFO - 'SHELL': '/bin/bash', 19:00:24 INFO - 'SHLVL': '1', 19:00:24 INFO - 'TERM': 'linux', 19:00:24 INFO - 'TMOUT': '86400', 19:00:24 INFO - 'USER': 'cltbld', 19:00:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:24 INFO - '_': '/tools/buildbot/bin/python'} 19:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:27 INFO - Installing collected packages: mozsystemmonitor 19:00:27 INFO - Running setup.py install for mozsystemmonitor 19:00:28 INFO - Successfully installed mozsystemmonitor 19:00:28 INFO - Cleaning up... 19:00:28 INFO - Return code: 0 19:00:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:00:28 INFO - Using env: {'DISPLAY': ':0', 19:00:28 INFO - 'HOME': '/home/cltbld', 19:00:28 INFO - 'LANG': 'en_US.UTF-8', 19:00:28 INFO - 'LANGUAGE': 'en_US:en', 19:00:28 INFO - 'LOGNAME': 'cltbld', 19:00:28 INFO - 'MAIL': '/var/mail/cltbld', 19:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:28 INFO - 'MOZ_NO_REMOTE': '1', 19:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:28 INFO - 'NO_EM_RESTART': '1', 19:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:28 INFO - 'PWD': '/builds/slave/test', 19:00:28 INFO - 'SHELL': '/bin/bash', 19:00:28 INFO - 'SHLVL': '1', 19:00:28 INFO - 'TERM': 'linux', 19:00:28 INFO - 'TMOUT': '86400', 19:00:28 INFO - 'USER': 'cltbld', 19:00:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:28 INFO - '_': '/tools/buildbot/bin/python'} 19:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:28 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:30 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:30 INFO - warning: no files found matching '*.txt' 19:00:30 INFO - no previously-included directories found matching 'build' 19:00:30 INFO - no previously-included directories found matching 'dist' 19:00:30 INFO - no previously-included directories found matching '.git*' 19:00:30 INFO - Installing collected packages: jsonschema, functools32 19:00:30 INFO - Running setup.py install for functools32 19:00:30 INFO - warning: no files found matching '*.txt' 19:00:30 INFO - no previously-included directories found matching 'build' 19:00:30 INFO - no previously-included directories found matching 'dist' 19:00:30 INFO - no previously-included directories found matching '.git*' 19:00:30 INFO - Successfully installed jsonschema functools32 19:00:30 INFO - Cleaning up... 19:00:30 INFO - Return code: 0 19:00:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:00:30 INFO - Using env: {'DISPLAY': ':0', 19:00:30 INFO - 'HOME': '/home/cltbld', 19:00:30 INFO - 'LANG': 'en_US.UTF-8', 19:00:30 INFO - 'LANGUAGE': 'en_US:en', 19:00:30 INFO - 'LOGNAME': 'cltbld', 19:00:30 INFO - 'MAIL': '/var/mail/cltbld', 19:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:30 INFO - 'MOZ_NO_REMOTE': '1', 19:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:30 INFO - 'NO_EM_RESTART': '1', 19:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:30 INFO - 'PWD': '/builds/slave/test', 19:00:30 INFO - 'SHELL': '/bin/bash', 19:00:30 INFO - 'SHLVL': '1', 19:00:30 INFO - 'TERM': 'linux', 19:00:30 INFO - 'TMOUT': '86400', 19:00:30 INFO - 'USER': 'cltbld', 19:00:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:30 INFO - '_': '/tools/buildbot/bin/python'} 19:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:30 INFO - Cleaning up... 19:00:30 INFO - Return code: 0 19:00:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:30 INFO - Using env: {'DISPLAY': ':0', 19:00:30 INFO - 'HOME': '/home/cltbld', 19:00:30 INFO - 'LANG': 'en_US.UTF-8', 19:00:30 INFO - 'LANGUAGE': 'en_US:en', 19:00:30 INFO - 'LOGNAME': 'cltbld', 19:00:30 INFO - 'MAIL': '/var/mail/cltbld', 19:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:30 INFO - 'MOZ_NO_REMOTE': '1', 19:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:30 INFO - 'NO_EM_RESTART': '1', 19:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:30 INFO - 'PWD': '/builds/slave/test', 19:00:30 INFO - 'SHELL': '/bin/bash', 19:00:30 INFO - 'SHLVL': '1', 19:00:30 INFO - 'TERM': 'linux', 19:00:30 INFO - 'TMOUT': '86400', 19:00:30 INFO - 'USER': 'cltbld', 19:00:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:30 INFO - '_': '/tools/buildbot/bin/python'} 19:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - Downloading docopt-0.6.1.tar.gz 19:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:33 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:33 INFO - Running setup.py install for blobuploader 19:00:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:33 INFO - Running setup.py install for requests 19:00:34 INFO - Running setup.py install for docopt 19:00:34 INFO - Successfully installed blobuploader requests docopt 19:00:34 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:34 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')]} 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 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')]} 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:34 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 19:00:34 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 19:00:34 INFO - Using env: {'DISPLAY': ':0', 19:00:34 INFO - 'HOME': '/home/cltbld', 19:00:34 INFO - 'LANG': 'en_US.UTF-8', 19:00:34 INFO - 'LANGUAGE': 'en_US:en', 19:00:34 INFO - 'LOGNAME': 'cltbld', 19:00:34 INFO - 'MAIL': '/var/mail/cltbld', 19:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:34 INFO - 'MOZ_NO_REMOTE': '1', 19:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:34 INFO - 'NO_EM_RESTART': '1', 19:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:34 INFO - 'PWD': '/builds/slave/test', 19:00:34 INFO - 'SHELL': '/bin/bash', 19:00:34 INFO - 'SHLVL': '1', 19:00:34 INFO - 'TERM': 'linux', 19:00:34 INFO - 'TMOUT': '86400', 19:00:34 INFO - 'USER': 'cltbld', 19:00:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:34 INFO - '_': '/tools/buildbot/bin/python'} 19:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:34 INFO - Running setup.py (path:/tmp/pip-lPj1tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:34 INFO - Running setup.py (path:/tmp/pip-_Vt_BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:34 INFO - Running setup.py (path:/tmp/pip-V4pcof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:34 INFO - Running setup.py (path:/tmp/pip-gv4FV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:34 INFO - Running setup.py (path:/tmp/pip-n8xmr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:34 INFO - Running setup.py (path:/tmp/pip-yyIrsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:35 INFO - Running setup.py (path:/tmp/pip-ITAWxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:35 INFO - Running setup.py (path:/tmp/pip-XpcYTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:35 INFO - Running setup.py (path:/tmp/pip-ohdRJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:35 INFO - Running setup.py (path:/tmp/pip-R0UrC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:35 INFO - Running setup.py (path:/tmp/pip-aTtXwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:35 INFO - Running setup.py (path:/tmp/pip-Ve4sOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:35 INFO - Running setup.py (path:/tmp/pip-h8vgoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:35 INFO - Running setup.py (path:/tmp/pip-AuwOSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:35 INFO - Running setup.py (path:/tmp/pip-wBvnn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:35 INFO - Running setup.py (path:/tmp/pip-PbG12i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:35 INFO - Running setup.py (path:/tmp/pip-VcP_2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:35 INFO - Running setup.py install for manifestparser 19:00:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:35 INFO - Running setup.py install for mozcrash 19:00:35 INFO - Running setup.py install for mozdebug 19:00:36 INFO - Running setup.py install for mozdevice 19:00:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for mozfile 19:00:36 INFO - Running setup.py install for mozhttpd 19:00:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for mozinfo 19:00:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for mozInstall 19:00:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for mozleak 19:00:36 INFO - Running setup.py install for mozlog 19:00:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for moznetwork 19:00:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:36 INFO - Running setup.py install for mozprocess 19:00:37 INFO - Running setup.py install for mozprofile 19:00:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:37 INFO - Running setup.py install for mozrunner 19:00:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:37 INFO - Running setup.py install for mozscreenshot 19:00:37 INFO - Running setup.py install for moztest 19:00:37 INFO - Running setup.py install for mozversion 19:00:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:37 INFO - Cleaning up... 19:00:37 INFO - Return code: 0 19:00:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:37 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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:37 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 19:00:37 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 19:00:37 INFO - Using env: {'DISPLAY': ':0', 19:00:37 INFO - 'HOME': '/home/cltbld', 19:00:37 INFO - 'LANG': 'en_US.UTF-8', 19:00:37 INFO - 'LANGUAGE': 'en_US:en', 19:00:37 INFO - 'LOGNAME': 'cltbld', 19:00:37 INFO - 'MAIL': '/var/mail/cltbld', 19:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:37 INFO - 'MOZ_NO_REMOTE': '1', 19:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:37 INFO - 'NO_EM_RESTART': '1', 19:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:37 INFO - 'PWD': '/builds/slave/test', 19:00:37 INFO - 'SHELL': '/bin/bash', 19:00:37 INFO - 'SHLVL': '1', 19:00:37 INFO - 'TERM': 'linux', 19:00:37 INFO - 'TMOUT': '86400', 19:00:37 INFO - 'USER': 'cltbld', 19:00:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:37 INFO - '_': '/tools/buildbot/bin/python'} 19:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:37 INFO - Running setup.py (path:/tmp/pip-ALwkri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:37 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)) 19:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:37 INFO - Running setup.py (path:/tmp/pip-__Tt4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:37 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)) 19:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:37 INFO - Running setup.py (path:/tmp/pip-uPiAY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:38 INFO - Running setup.py (path:/tmp/pip-g2EIJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:38 INFO - Running setup.py (path:/tmp/pip-rhz6tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:38 INFO - Running setup.py (path:/tmp/pip-yVr5iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:38 INFO - Running setup.py (path:/tmp/pip-YJENH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:38 INFO - Running setup.py (path:/tmp/pip-pUj38i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:38 INFO - Running setup.py (path:/tmp/pip-dqupeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:38 INFO - Running setup.py (path:/tmp/pip-vUKzpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:38 INFO - Running setup.py (path:/tmp/pip-ExkoHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:38 INFO - Running setup.py (path:/tmp/pip-QwBFco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:38 INFO - Running setup.py (path:/tmp/pip-sV_BNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:38 INFO - Running setup.py (path:/tmp/pip-lf_OVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:38 INFO - Running setup.py (path:/tmp/pip-oloEO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:38 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)) 19:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:38 INFO - Running setup.py (path:/tmp/pip-iqiICB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:39 INFO - Running setup.py (path:/tmp/pip-o5Ssro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:40 INFO - Downloading blessings-1.6.tar.gz 19:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:41 INFO - Installing collected packages: blessings 19:00:41 INFO - Running setup.py install for blessings 19:00:41 INFO - Successfully installed blessings 19:00:41 INFO - Cleaning up... 19:00:41 INFO - Return code: 0 19:00:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:41 INFO - Reading from file tmpfile_stdout 19:00:41 INFO - Current package versions: 19:00:41 INFO - argparse == 1.2.1 19:00:41 INFO - blessings == 1.6 19:00:41 INFO - blobuploader == 1.2.4 19:00:41 INFO - docopt == 0.6.1 19:00:41 INFO - functools32 == 3.2.3-2 19:00:41 INFO - jsonschema == 2.5.1 19:00:41 INFO - manifestparser == 1.1 19:00:41 INFO - mozInstall == 1.12 19:00:41 INFO - mozcrash == 0.17 19:00:41 INFO - mozdebug == 0.1 19:00:41 INFO - mozdevice == 0.48 19:00:41 INFO - mozfile == 1.2 19:00:41 INFO - mozhttpd == 0.7 19:00:41 INFO - mozinfo == 0.9 19:00:41 INFO - mozleak == 0.1 19:00:41 INFO - mozlog == 3.3 19:00:41 INFO - moznetwork == 0.27 19:00:41 INFO - mozprocess == 0.23 19:00:41 INFO - mozprofile == 0.28 19:00:41 INFO - mozrunner == 6.12 19:00:41 INFO - mozscreenshot == 0.1 19:00:41 INFO - mozsystemmonitor == 0.3 19:00:41 INFO - moztest == 0.7 19:00:41 INFO - mozversion == 1.4 19:00:41 INFO - psutil == 3.1.1 19:00:41 INFO - requests == 1.2.3 19:00:41 INFO - wsgiref == 0.1.2 19:00:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 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 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:41 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 19:00:41 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 19:00:41 INFO - Using env: {'DISPLAY': ':0', 19:00:41 INFO - 'HOME': '/home/cltbld', 19:00:41 INFO - 'LANG': 'en_US.UTF-8', 19:00:41 INFO - 'LANGUAGE': 'en_US:en', 19:00:41 INFO - 'LOGNAME': 'cltbld', 19:00:41 INFO - 'MAIL': '/var/mail/cltbld', 19:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:41 INFO - 'MOZ_NO_REMOTE': '1', 19:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:41 INFO - 'NO_EM_RESTART': '1', 19:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:41 INFO - 'PWD': '/builds/slave/test', 19:00:41 INFO - 'SHELL': '/bin/bash', 19:00:41 INFO - 'SHLVL': '1', 19:00:41 INFO - 'TERM': 'linux', 19:00:41 INFO - 'TMOUT': '86400', 19:00:41 INFO - 'USER': 'cltbld', 19:00:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:41 INFO - '_': '/tools/buildbot/bin/python'} 19:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 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)) 19:00:41 INFO - Cleaning up... 19:00:41 INFO - Return code: 0 19:00:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, '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': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', '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 19:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:41 INFO - Using env: {'DISPLAY': ':0', 19:00:41 INFO - 'HOME': '/home/cltbld', 19:00:41 INFO - 'LANG': 'en_US.UTF-8', 19:00:41 INFO - 'LANGUAGE': 'en_US:en', 19:00:41 INFO - 'LOGNAME': 'cltbld', 19:00:41 INFO - 'MAIL': '/var/mail/cltbld', 19:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:41 INFO - 'MOZ_NO_REMOTE': '1', 19:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:41 INFO - 'NO_EM_RESTART': '1', 19:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:41 INFO - 'PWD': '/builds/slave/test', 19:00:41 INFO - 'SHELL': '/bin/bash', 19:00:41 INFO - 'SHLVL': '1', 19:00:41 INFO - 'TERM': 'linux', 19:00:41 INFO - 'TMOUT': '86400', 19:00:41 INFO - 'USER': 'cltbld', 19:00:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:41 INFO - '_': '/tools/buildbot/bin/python'} 19:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:41 INFO - Cleaning up... 19:00:41 INFO - Return code: 0 19:00:41 INFO - Running post-action listener: _resource_record_post_action 19:00:41 INFO - Running post-action listener: _start_resource_monitoring 19:00:41 INFO - Starting resource monitoring. 19:00:41 INFO - [mozharness: 2016-08-04 02:00:41.913498Z] Finished create-virtualenv step (success) 19:00:41 INFO - [mozharness: 2016-08-04 02:00:41.914048Z] Running install step. 19:00:41 INFO - Running pre-action listener: _resource_record_pre_action 19:00:41 INFO - Running main action method: install 19:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:42 INFO - Reading from file tmpfile_stdout 19:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:42 INFO - Reading from file tmpfile_stdout 19:00:42 INFO - Output received: 19:00:42 INFO - Usage: mozinstall [options] installer 19:00:42 INFO - Options: 19:00:42 INFO - -h, --help show this help message and exit 19:00:42 INFO - -d DEST, --destination=DEST 19:00:42 INFO - Directory to install application into. [default: 19:00:42 INFO - "/builds/slave/test"] 19:00:42 INFO - --app=APP Application being installed. [default: firefox] 19:00:42 INFO - mkdir: /builds/slave/test/build/application 19:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:00:58 INFO - Reading from file tmpfile_stdout 19:00:58 INFO - Output received: 19:00:58 INFO - /builds/slave/test/build/application/firefox/firefox 19:00:58 INFO - Running post-action listener: _resource_record_post_action 19:00:58 INFO - [mozharness: 2016-08-04 02:00:58.301816Z] Finished install step (success) 19:00:58 INFO - [mozharness: 2016-08-04 02:00:58.302091Z] Running run-tests step. 19:00:58 INFO - Running pre-action listener: _resource_record_pre_action 19:00:58 INFO - Running main action method: run_tests 19:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:58 INFO - Python 2.7.3 19:00:58 INFO - Return code: 0 19:00:58 INFO - grabbing minidump binary from tooltool 19:00: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')]} 19:00:58 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 0x1442570>, '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 0x1443470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1443900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:58 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 19:00:58 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 19:00:58 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 19:00:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:58 INFO - Return code: 0 19:00:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:00:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:00:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:58 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:00:58 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:00:58 INFO - Using env: {'DISPLAY': ':0', 19:00:58 INFO - 'HOME': '/home/cltbld', 19:00:58 INFO - 'LANG': 'en_US.UTF-8', 19:00:58 INFO - 'LANGUAGE': 'en_US:en', 19:00:58 INFO - 'LOGNAME': 'cltbld', 19:00:58 INFO - 'MAIL': '/var/mail/cltbld', 19:00:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:58 INFO - 'MOZ_NO_REMOTE': '1', 19:00:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:58 INFO - 'NO_EM_RESTART': '1', 19:00:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:58 INFO - 'PWD': '/builds/slave/test', 19:00:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:58 INFO - 'SHELL': '/bin/bash', 19:00:58 INFO - 'SHLVL': '1', 19:00:58 INFO - 'TERM': 'linux', 19:00:58 INFO - 'TMOUT': '86400', 19:00:58 INFO - 'USER': 'cltbld', 19:00:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470276004.666041-99612504', 19:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:58 INFO - '_': '/tools/buildbot/bin/python'} 19:00:58 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:00:58 INFO - mozversion application_buildid: 20160803173221 19:00:58 INFO - mozversion application_changeset: 8538a05d5ba3a006dc77bb85011416f0aa70335c 19:00:58 INFO - mozversion application_display_name: Nightly 19:00:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:58 INFO - mozversion application_name: Firefox 19:00:58 INFO - mozversion application_remotingname: firefox 19:00:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:00:58 INFO - mozversion application_vendor: Mozilla 19:00:58 INFO - mozversion application_version: 51.0a1 19:00:58 INFO - mozversion platform_buildid: 20160803173221 19:00:58 INFO - mozversion platform_changeset: 8538a05d5ba3a006dc77bb85011416f0aa70335c 19:00:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:00:58 INFO - mozversion platform_version: 51.0a1 19:00:58 INFO - using testdate: 1470276058 19:00:58 INFO - actual date: 1470276058 19:00:58 INFO - starting webserver on 'localhost:41080' 19:00:58 INFO - SUITE-START | Running 2 tests 19:00:58 INFO - TEST-START | dromaeo_css 19:00:58 INFO - operating with platform_type : linux_ 19:00:58 INFO - Initialising browser for dromaeo_css test... 19:00:58 INFO - TEST-INFO | started process 1004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyH3C5h/profile http://localhost:41080/getInfo.html) 19:01:03 INFO - PROCESS | 1004 | __metrics Screen width/height:1600/1200 19:01:03 INFO - PROCESS | 1004 | colorDepth:24 19:01:03 INFO - PROCESS | 1004 | Browser inner width/height: 1024/697 19:01:03 INFO - PROCESS | 1004 | __metrics 19:01:04 ERROR - PROCESS | 1004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:01:05 INFO - TEST-INFO | 1004: exit 0 19:01:05 INFO - Browser initialized. 19:01:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:05 INFO - TEST-INFO | started process 1135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyH3C5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:17 INFO - PROCESS | 1135 | RSS: Main: 164311040 19:01:17 INFO - PROCESS | 1135 | 19:02:06 INFO - PROCESS | 1135 | 1470276126792 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] 19:04:19 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41080/tests/dromaeo/cssquery-ext.html) 19:04:20 INFO - PROCESS | 1135 | RSS: Main: 167075840 19:04:20 INFO - PROCESS | 1135 | 19:07:23 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-ext.html (next: http://localhost:41080/tests/dromaeo/cssquery-jquery.html) 19:07:23 INFO - PROCESS | 1135 | RSS: Main: 166207488 19:07:23 INFO - PROCESS | 1135 | 19:10:25 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41080/tests/dromaeo/cssquery-mootools.html) 19:10:26 INFO - PROCESS | 1135 | RSS: Main: 169914368 19:10:26 INFO - PROCESS | 1135 | 19:13:28 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41080/tests/dromaeo/cssquery-prototype.html) 19:13:29 INFO - PROCESS | 1135 | RSS: Main: 164032512 19:13:29 INFO - PROCESS | 1135 | 19:16:31 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41080/tests/dromaeo/cssquery-yui.html) 19:16:32 INFO - PROCESS | 1135 | RSS: Main: 166285312 19:16:32 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | Cycle 1(1): loaded http://localhost:41080/tests/dromaeo/cssquery-yui.html (next: http://localhost:41080/tests/dromaeo/cssquery-dojo.html) 19:19:35 INFO - PROCESS | 1135 | RSS: Main: 169385984 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | __start_tp_report 19:19:35 INFO - PROCESS | 1135 | _x_x_mozilla_page_load 19:19:35 INFO - PROCESS | 1135 | _x_x_mozilla_page_load_details 19:19:35 INFO - PROCESS | 1135 | |i|pagename|runs| 19:19:35 INFO - PROCESS | 1135 | |0;dojo.html;2633.61812537182;2655.601659751037;2667.9199624011276;2675.3579141006167;2684.6778386593605;4732.716037037781;4791.472937976824;4855.198892182794;4870.780814863331;4919.827806026789;4646.51211622779;4696.530346965302;4708.458527269357;4855.150348688983;4926.802927882889;4298.957010429903;4346.717463364887;4356.1723272578265;4397.230484665187;4423.447069116361;4409.338599210112;4415.293553031515;4418.072204836972;4455.131249406367;4491.505934347219;4351.477822661269;4396;4408.118376324748;4416.315471101984;4496.595306422405;4415.381846541487;4434.35701823237;4448.955510444886;4467.553244675539;4473.46318441789;4429.6899217054815;4438.400815889878;4441.489228738672;4454.886278430393;4471.28459446487;4768.213244814601;4820.855374338776;4839.225723884161;4865.82969596066;4936.506349365035;5233.241180028875;5253.658512196695;5273.1035723927025;5275.657082289677;5290.629655924087;5292.364916210041;5293.04725149473;5315.840524784263;5334.0665383557725;5351.197320401932;4715.7877895494785;4831.0820944020525;4843.370361852936;4868.756562171877;4883.853484395474;5284.260203571503;5370.409254981949;5380.031594312983;5452.345718513804;5462.863428414322;5226.137687281632;5226.477352264819;5229.08491014071;5237.816676416307;5241.606879484054;4967.801287948441;5142.408623008327;5154.793808247703;5180.948190518122;5232.189010703347;5131.717755523482;5168.483151684802;5168.612354073384;5213.087709650796;5226.268322434862;5173.042987047408;5209.322788037531;5212.530872221519;5212.55693266069;5247.9737601311745;4212.3681447782465;4365.672574556921;4435.889102772457;4438.778061096997;4443.800028998703;3820.8662696806036;3827.5981021992848;3840.4047372657283;3875.147467557133;3884.786336751449;4517.593416592523;4542.31865220213;4569.337446070368;4579.496255411902;4611.1930412177735;5081.2378143278065;5193.37679478465;5209.895802083937;5224.791008359699;5303.098473259555;4498.1003799239625;4508.098380323949;4517.81928722854;4532.9773351133035;4558.635309175258;4651.3720647712125;4691.390119284471;4696.131215725033;4700.835470758507;4704.694194877322;4701.412323459636;4821.180399332052;4883.682560633548;4887.193613053806;4991.425986011655;5238.68567885928;5256.868578285574;5278.6832790031185;5284.920726189187;5290.312259406252;4924.556789888928;4931.901361972668;4939.901201975868;4951;5010.9248361273885;4937.382827146606;5045.495450455072;5076.466970968143;5087.135187018142;5130.615203859651;5179.30079439286;5187.144121219956;5192.273081768631;5228.346456692913;5238.371395432572;4974.12952733263;5008.148614735576;5034.766482211881;5060.468650791614;5065;4902.362692850049;5067.163917953497;5112.923306150336;5127.256547800623;5176.922346164735;5058.747062646779;5062.316587260672;5069.264956581349;5073.644844860824;5125.615578831528;5197.740112994411;5203.635745497931;5210;5210.8957820844125;5218.66078704883;4773.451053128934;5013.674111182907;5050.646454748279;5064.063148317573;5144.6398752087 19:19:35 INFO - PROCESS | 1135 | |1;ext.html;538.7764077907667;539.8434454008335;548.5063442901388;554.6976897590814;569.390751895472;35533.64466355336;39982;40043.19913601726;40104.59895401045;40261;39227.21545569094;39736;39774.40338394919;39893.401598975965;39913.40129898054;7692.576908270057;7769.300762931335;7828.334591559725;7838.529688218697;7850.607469626524;7765.8058548536455;7782.49413788102;7827.882581761278;7840.372770178401;7841.725539606115;7796.1814009529035;7824.256695613907;7827.88258176125;7861.135275119732;7901.881471777928;7827.765167044998;7846.254605812439;7852.21477852216;7872.370210383156;7882.448228623999;7534.698612055511;7602.581857997808;7607.923920760777;7626.313631773111;7630.351420129296;37573.62426375729;37860.81069594635;37894.81052594747;37933.81033094844;38000.42999354984;2832.22113918674;3020.4714175019285;3134.81191128533;3253.9186817762557;3395.4906763985355;29086.127416177547;29122.271943201376;29155;29599.260018499495;30705.846470767727;3034.7117023882697;3043.6804135565667;3127.796693214934;3141.780075394723;3196.2968147007623;250320;250800;251970;253054;253765;51487.48512514902;52283.73858130685;52460;52934.73532632389;53004.73497632487;32936;33783.493247601305;33840.984770456926;35875.282494349965;35989.8200509001;15935.840641593435;16052.197390130446;16119.355225791072;16186.271617777229;16201.108939008467;12073.154879158375;12112.757744845054;12191.45138468771;12203.69490762738;12207.694807629703;18240.45278641643;18281.17734701915;18322.267109315744;18466.169022394024;18539.81460185408;6383.3396531422795;6646.567973081735;6676.298988606127;6769.729210831511;6832.795016149524;813.4346629092723;835.8620827563384;905.6060613633091;911.4485736129678;985.1527686189871;26496.33759155998;28015.579766303523;28102.43795124127;28483.715162848108;28808.567871481944;951.4481600671733;988.48104745008;1004.7036124343336;1061.1722856172198;1106.8893110688866;15053.397864085315;15058;15074.321655525528;15084.77763810379;15091.471798487;395864;401750;401788;403115;403283;50668.49331506711;50721;50892.74553627208;51162.488375115776;51189;1159.646307876106;1185.525789684116;1213.5813144465146;1214.8724383939737;1218.945147468366;26147;27823.721762782112;29835.254118647208;32091.35817283688;33024.834875825465;49274;50000.74999624979;50135.24797128119;50146.49853501418;50182.749086254335;369562;372348;372885;373144;374163;37815.05462363353;39297.60702392939;39693;39826;39906.004699764315;42437.78781106198;43211.783941080095;43334.34998475089;43485;44001.67994960157;36082.4587631191;36291;36456.635433646385;36904.81547592245;37260.81369593243;36701.63298366982;37074.44388334231;37291.62708372882;37358;38370.42444363393;35749.92750217498;36608;36700.81649591735;36764.080897977765;37083.44374834433;32210.516842246918;34104.31791364109;34349.65650343464;34582.82708586441;34944.82527587346;26038.86980565085;26079.739202607732;26226.868865656314;26261;26673.33316667099 19:19:35 INFO - PROCESS | 1135 | |2;jquery.html;342.318785616623;357.5994885727985;359.8254846399496;368.9243705040467;379.56539761972545;16510.091944943037;17181.48455546334;17326.65346693067;17915.462536123905;18023.90988045058;14618;14798.482053128142;14857.257137143153;14918.62703432412;14937.701245975073;5019.297298378239;5214.504622060898;5225.346831646044;5247.317848679666;5253.0544501989625;3739.1026153723183;5044.949550504484;5665.263515742948;5931.406859314077;5953.553483488734;5966.552508561854;5973.313068997056;5989.281286245635;5993.910091348634;6024.795040991798;6009.338972712998;6033.09503574463;6086.573939824214;6088.756449742005;6096.481799047064;5130.204818253177;5260.815871444519;5279.815206467755;5285.07511185541;5285.947140528584;20618.381448556418;20824.895875520677;20895.164193432243;21505.354839354844;21633.134674612997;1893.7916829148783;2147.881866497342;2171.250918433138;2431.671724317212;2467.9634553487576;13570.253636050013;13577.321133943264;13829.446822127104;14085.788713169311;14167.645808854759;1698.5329034515485;1698.8131305556378;1772.2113659421564;1822.7539282197;1835.7246413038151;68816.6559167206;69877.65061174662;70497.2950270496;71647.64176179138;71836.64081679558;9297.95351023254;9460.24318054554;9597.472139032281;9646.90353096474;9884.901150988542;13176.73646527064;13228.537001205104;13235.205887646773;13240.668983275302;13282.402291896695;7170.8207294817;7255.165655949633;7329.706811727471;7381.409487241008;7423.369013633794;7076.044733960953;7132.893006604905;7245.239249878792;7317.231690672403;7339.266073392725;5744.827655170351;5871.618344807659;5882.382349853204;5889.823305300848;6205.379462053849;1529.2506671730994;1637.10777626194;1733.34133029448;1766.1522469214592;1821.3989383503413;782.5383024015858;807.5316316536512;817.9386546009073;878.3193025405362;946.5929650250321;17966.191521381308;18030.90984545095;18646.813531864507;18887.338943136925;19069.618607628046;895.4761464543316;907.9909200908038;930.3952430919821;941.5951141009294;946.0917519181526;10024.899751002542;10682.359058456517;10773.299735517166;10828;10912.836307455394;411491;419274;431135;432035;433486;74173;75958.62020689862;79613;80383.59808200922;80494;903.4534106865383;915.54680433186;936.5925822267335;940.6331530703031;946.6213514594217;15939.282732277306;16558.254878530253;16670.916645416695;16809.243584038504;17033.31866725367;35146.36402269891;35775.64224357723;36553.45169822402;36674.44988325231;37092.25815483729;47369;47989.5201047985;50147.74926125346;50538.2419263704;51227.2315915269;7279.563226206445;7316.451266154953;7393.741219057307;7443.144038435433;7647.847043059219;11558.479868405773;11628.767424651629;11757.764844702888;12145;12211.084168687561;10093.949530252301;10279.434631095062;10420.947895260779;10492.580296788348;10508.686414198226;5069.645124841226;9912.405255684682;10177.134943529883;10486.16110711126;10612.628558000433;9956.850647240442;10030.849537256801;10188.337758046;10430.426326552113;10910.672679819618;7181.712731490682;7326.413886889142;7400.814979625337;7486.363659088821;7682.539047657158;9642.855357169508;9736.004119155414;9841.360311579725;9945.403275803475;10339.172866170838 19:19:35 INFO - PROCESS | 1135 | |3;mootools.html;1359.7076628524865;1383.3152589468216;1444.2201211345873;1606.1647943069597;1641.998380987598;6095.299040610331;6654.86690266195;6728.59628422295;7206.099237595301;7220.350168484835;6831.316868313166;7034.1910680271785;7107.644617769117;7120.715171393151;7131.322524360177;2083.260442542898;2111.144986280559;2119.5337025854365;2120.4486833423343;2130.6910497977783;2068.720722702431;2083.5312054787705;2095.559932414195;2095.706601075851;2108.3569511299047;2043.5708501214688;2051.107768120872;2052.5586998795256;2053.035073515445;2127.5532138250987;2099.391176558796;2105.3683894831565;2105.49468127649;2106.799854013866;2117.04732870209;2058.5162486815584;2059.06312627754;2095.371388583419;2102.096098677568;2108.135664377613;7188.388986936065;7238.638068096627;7240.674169662378;7242.23956484572;7242.6378681065735;3983.382575700771;4171.290880550314;4179.373094035888;4190.141021090669;4207.852725154605;2682.158862617832;2758.1449750577385;2789.9581506277423;2797.9440411191663;2798.2164993801766;865.2472349056361;894.7941973346167;925.296774451415;933.272047802715;950.7337945375236;9216.631334746602;9285.721428357092;9316.44101353921;9404.529773511296;9420.105090016506;3792.9620703792607;3830.0999265172663;3944.092858642471;3967.3255546557157;4002.579729128458;8150.633221504928;8154.592270386457;8162.632681529345;8167.305779008732;8191.754247372588;4178.498580170338;4186.869545222773;4190.685698572558;4200.579942005775;4215.325547912381;3452.913677158041;3808;3847.846086156578;3849.1531862990096;3908.5700572936953;3377.7297816174646;3407.1311815486893;3545.2023294758474;3552.4671299304796;3567.661072198137;1124.9268797528134;1142.2289954280827;1146.3523109443138;1155.7919574476507;1173.3018853781987;645.6319897658384;774.1600363605438;791.4143533785073;791.7070683847013;810.440795850861;4555.453345598549;4636.211843986531;4643.907121857544;4673.883152921204;4724.905501889943;392.4956430986169;393.6358868047045;398.1280994621769;402.61147992187097;406.89013966229544;3151.8108913465267;3152.9684703153134;3164.256399746058;3164.810111393324;3228.2413632796274;7955.641996110189;8296.128906464855;8371.832563348698;8400.747977560683;8477;8543.145685431407;8543.530105844115;8571.314294856396;8581.828363432696;8601.698940537051;6635.734570617218;6758.797236082925;6764.5603035802515;6786.423154031864;6813.284605116491;4781.641376896816;4810.615150787999;4839.806407743792;4898.314236007033;4964.702117872939;7814.960925195338;7843.647035883513;7879.724209652634;7926.24700653437;7990.720324788605;7947.84104317922;8002.679892804223;8020.518768873886;8181.713640022571;8190.549519776469;5415;6199.783007594712;6225.595336303126;6272.121902933502;6421;6515.12045873801;6643.169603799525;6662.267150613526;6662.900056499059;6744.460443164633;5775.653460792366;6050.42520960508;6076.483498902466;6146.323904370605;6146.631202127886;5878.441548053099;5979.252593425822;6045.093236014633;6082.148499210202;6100.176476175837;5594.328680558359;5626.943730562805;5634.830955071355;5649.887002260014;5663.66018038919;4019.376996565537;4072.450219220486;4119.876403707894;4164.208800327928;4197.181549597921;4112.090022236958;4113.958860411477;4136.400221967738;4139.81370838319;4183.811728472165 19:19:35 INFO - PROCESS | 1135 | |4;prototype.html;281.93092692290384;287.5126660310773;289.4962764789266;291.9810212336197;292.94287613915293;4978.228374601938;5027.220780778981;5027.622928280375;5041.596672266219;5058.570021548164;4890.119778439879;4902.828401005965;4915.705057696532;4928.950710492894;4987.326710894028;3689.2252626948375;3738.4392341148773;3869.2454971280613;3882.864099756509;3896.8246428910766;3894.922101557967;3904.882853514399;3906.277338692337;3930;3933.5869733677982;3877.5734669186368;3887.300285948528;3894.532656081274;3896.376579747241;3901.7073719471155;3737.4206997915094;3861.4593956846065;3875.2636998970247;3878.5733569307354;3884.8633251711444;3412.607550131742;3417.96582034179;3422.3326451342;3428.3143371325837;3428.9657103428895;4830.275458681191;4830.4203495580405;4839.467658557556;4854.68444551103;4862.294967229767;4307.978460107679;4437.668699390202;4444.777761111932;4445.777711114463;4463.303944501069;5136.383633963948;5177.301064356301;5182.766775495112;5185.974070129625;5196.870078248036;3703.6111208323277;3708.7774733516076;3708.796016219107;3719.962800372016;3725.9627403725885;5462.644928079662;5464.617476776627;5467.824417750163;5469.3983661797565;5477.657973796446;3511.701505372072;3698.3712768829364;3707.3141468828353;3718.9442158367647;3724.4227144792058;3757.680597149273;3778.8110594470168;3779.3764028935466;3786.8036538807423;3795.7532760370486;4318.978405107954;4345.97827010863;4356;4359.38968544404;4360.607545320936;5124.564412024945;5130.410002849645;5225.869353266199;5272.314599102092;5279.498447647467;1289.1427200911476;1302.426932149851;1305.5104335874048;1306.301128896036;1309.4631201207649;777.992220077792;800.5516910530006;814.2940539569593;814.3566582399956;820.3560205238858;4410.713303635318;4434.711743736647;4623.329617205486;4643.605293550018;4680.321353403738;5404.189371594213;5423.647462914898;5433.320834895638;5440.6735595864375;5444.3194600674915;4567.51242894208;4582.587567118975;4633.86098417048;4637.234856248681;4648.233041548175;2760.3513174403997;2846.985765071203;2883.1062370665163;2883.351245969682;2886.6680331761695;5072.873178170576;5090.1240798948475;5094.363204599425;5098.337216161875;5104.285400043997;5262.55268302191;5540.861478463071;5544.611877168641;5550;5564.554835613141;5052.242163675478;5059.949400505948;5065.949340506621;5086.821961231339;5096.796128154906;5364.517193452608;5400.216968539618;5414.648047876875;5447.1829225616475;5465.234867118527;5010.273510341053;5240.318758561515;5242.737863106753;5306.832496850687;5315.93681263741;5068.26510156018;5069.9746501267255;5081.161608334583;5081.568066714222;5110.8466745997675;3690.538682664667;3691.3171063353366;3699.186179040607;3701.981490092532;3707.369747142938;5214.97392513035;5344.518993290622;5423.213634023124;5434.483724046209;5442.972785136049;5231.55531779803;5255.448177941261;5259.47405259471;5260.552853007384;5273.419923808301;5251.267081863052;5271.525562699376;5280.808464487195;5289.4710528948335;5291.629585928948;4908.28829819667;5164.431912489548;5183.248428977702;5204.0892843752945;5204.661696989683;5042.067217564762;5171.482851714798;5293.947060529499;5299.648589609625;5301.443348448512;5166.741662916915;5177.559907407913;5189.6107791915;5192.117340052276;5192.350956130484 19:19:35 INFO - PROCESS | 1135 | |5;yui.html;621.0342916764431;621.2141640824357;697.5849369625074;733.6845156582667;748.5957582905231;12406;12831.615051548446;13075;13625.386857591408;13631.659208519779;13387.59837204883;13639.386227619756;13665.590032299022;13726.45094196231;13730.931345343259;626.2203556572074;753.898223739795;773.0182668011622;773.9397026074258;774.2915232562199;757.4811254290801;764.7246991083206;764.9196834332398;785.0892964161574;785.505131766986;805.673702150627;807.8828569857396;810.7081450677751;811.736185739637;813.4021494201756;794.1542257495748;801.1307731111722;803.2008151888908;803.7749430159565;806.3388021822108;584.220066211608;584.2959234122915;585.4116612804147;590.5482306035886;594.6937327276456;12386.938065309705;12399;12533.686657833536;12540.059495537871;12546.1844980076;13139.802902956464;13293.138960545532;13494.392752326168;13498.662533436644;13781;9596.184324332371;9630.518474076338;9687.70936871895;9696.660616878446;9905.801883962353;3206.5190221466964;3252.2194673278477;3258.397196518628;3280.1471617379416;3283.8522266497826;62976;63797.043044354374;64558;66199.00701489433;66342.3365766341;9963.850542241873;10221.488925553693;10267.794644107076;10286;10414.5834166634;19998.90000549988;20010.199592016448;20018.499537511678;20036.89981550083;20073;6577.901331480031;6589.86820263592;6624;6626.801195964129;6863.176418829772;3543.5825917782868;3744.7565908216425;3771.9434208486896;3802.7718336899875;3923.0388554803685;2756.0767143007315;2806.270369703851;2826.392325649995;2842.303635609289;2844.672862620825;468.7867020505662;479.2093046473347;485.18004572272747;488.23834817684525;495.23238979581504;494.3400560252032;587.4008511318432;587.9088741245029;590.2091197794975;593.8542528986371;7328.120625524864;7800.414968877357;7843.762614055973;7910.327622152066;8027.598620068973;509.23868816120137;515.8452464260707;534.516262782175;580.6980370207468;581.3169525807244;3479.2519608283833;3539.380608393521;3594.3350480161253;3784.6215378462484;3819.350710379242;50232;77453.2254677446;79853.60073199598;80846.19153808504;92250.53874730718;80319.19680803234;82543;82800.58599707084;82816;84054.5797271022;43644.56355436405;58009;71121.64439177874;71614;73656.99999999892;7682.8079298018;7691.692332306645;7929.207079292025;7999.560024198725;8091.06952700447;43495.565044349154;44250.55749442593;45290.773546132055;45298.32052519281;46537.767311163225;35775.82112089423;36155;38252;38452.42321365126;39790.80104599459;10905.764318314568;11263.831042534204;11426.94286528562;11591.072714182677;11786.351750653796;11352.091832653534;11441;11469.713257168303;11691.941540292244;12168.600610929856;10297.691069267934;10498.3329275382;10620.415877126523;10636.734081648021;10743.409112498888;10352.327098738559;10567.682969510926;10671.786564268516;11076.612318569134;11112.944435277772;9864.5560949756;9937.304388692723;10004.449755263238;10523.736906577396;11222.55109795599;7892.131865494676;8167.264946154874;8881.822363552821;9627.470489123165;9786.85319720219;8618.310535157298;8627.654893804429;8869;9080.863787043332;9087.454752714859 19:19:35 INFO - PROCESS | 1135 | __end_tp_report 19:19:35 INFO - PROCESS | 1135 | __start_cc_report 19:19:35 INFO - PROCESS | 1135 | _x_x_mozilla_cycle_collect,379 19:19:35 INFO - PROCESS | 1135 | __end_cc_report 19:19:35 INFO - PROCESS | 1135 | __startTimestamp1470277175719__endTimestamp 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | ------- Summary: start ------- 19:19:35 INFO - PROCESS | 1135 | Number of tests: 6 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#0] dojo.html Cycles:165 Average:4810.03 Median:4936.51 stddev:527.05 (10.7%) stddev-sans-first:500.25 19:19:35 INFO - PROCESS | 1135 | Values: 2633.6 2655.6 2667.9 2675.4 2684.7 4732.7 4791.5 4855.2 4870.8 4919.8 4646.5 4696.5 4708.5 4855.2 4926.8 4299.0 4346.7 4356.2 4397.2 4423.4 4409.3 4415.3 4418.1 4455.1 4491.5 4351.5 4396.0 4408.1 4416.3 4496.6 4415.4 4434.4 4449.0 4467.6 4473.5 4429.7 4438.4 4441.5 4454.9 4471.3 4768.2 4820.9 4839.2 4865.8 4936.5 5233.2 5253.7 5273.1 5275.7 5290.6 5292.4 5293.0 5315.8 5334.1 5351.2 4715.8 4831.1 4843.4 4868.8 4883.9 5284.3 5370.4 5380.0 5452.3 5462.9 5226.1 5226.5 5229.1 5237.8 5241.6 4967.8 5142.4 5154.8 5180.9 5232.2 5131.7 5168.5 5168.6 5213.1 5226.3 5173.0 5209.3 5212.5 5212.6 5248.0 4212.4 4365.7 4435.9 4438.8 4443.8 3820.9 3827.6 3840.4 3875.1 3884.8 4517.6 4542.3 4569.3 4579.5 4611.2 5081.2 5193.4 5209.9 5224.8 5303.1 4498.1 4508.1 4517.8 4533.0 4558.6 4651.4 4691.4 4696.1 4700.8 4704.7 4701.4 4821.2 4883.7 4887.2 4991.4 5238.7 5256.9 5278.7 5284.9 5290.3 4924.6 4931.9 4939.9 4951.0 5010.9 4937.4 5045.5 5076.5 5087.1 5130.6 5179.3 5187.1 5192.3 5228.3 5238.4 4974.1 5008.1 5034.8 5060.5 5065.0 4902.4 5067.2 5112.9 5127.3 5176.9 5058.7 5062.3 5069.3 5073.6 5125.6 5197.7 5203.6 5210.0 5210.9 5218.7 4773.5 5013.7 5050.6 5064.1 5144.6 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#1] ext.html Cycles:180 Average:49666.74 Median:205251.00 stddev:91715.63 (44.7%) stddev-sans-first:91898.74 19:19:35 INFO - PROCESS | 1135 | Values: 538.8 539.8 548.5 554.7 569.4 35533.6 39982.0 40043.2 40104.6 40261.0 39227.2 39736.0 39774.4 39893.4 39913.4 7692.6 7769.3 7828.3 7838.5 7850.6 7765.8 7782.5 7827.9 7840.4 7841.7 7796.2 7824.3 7827.9 7861.1 7901.9 7827.8 7846.3 7852.2 7872.4 7882.4 7534.7 7602.6 7607.9 7626.3 7630.4 37573.6 37860.8 37894.8 37933.8 38000.4 2832.2 3020.5 3134.8 3253.9 3395.5 29086.1 29122.3 29155.0 29599.3 30705.8 3034.7 3043.7 3127.8 3141.8 3196.3 250320.0 250800.0 251970.0 253054.0 253765.0 51487.5 52283.7 52460.0 52934.7 53004.7 32936.0 33783.5 33841.0 35875.3 35989.8 15935.8 16052.2 16119.4 16186.3 16201.1 12073.2 12112.8 12191.5 12203.7 12207.7 18240.5 18281.2 18322.3 18466.2 18539.8 6383.3 6646.6 6676.3 6769.7 6832.8 813.4 835.9 905.6 911.4 985.2 26496.3 28015.6 28102.4 28483.7 28808.6 951.4 988.5 1004.7 1061.2 1106.9 15053.4 15058.0 15074.3 15084.8 15091.5 395864.0 401750.0 401788.0 403115.0 403283.0 50668.5 50721.0 50892.7 51162.5 51189.0 1159.6 1185.5 1213.6 1214.9 1218.9 26147.0 27823.7 29835.3 32091.4 33024.8 49274.0 50000.7 50135.2 50146.5 50182.7 369562.0 372348.0 372885.0 373144.0 374163.0 37815.1 39297.6 39693.0 39826.0 39906.0 42437.8 43211.8 43334.3 43485.0 44001.7 36082.5 36291.0 36456.6 36904.8 37260.8 36701.6 37074.4 37291.6 37358.0 38370.4 35749.9 36608.0 36700.8 36764.1 37083.4 32210.5 34104.3 34349.7 34582.8 34944.8 26038.9 26079.7 26226.9 26261.0 26673.3 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#2] jquery.html Cycles:180 Average:25529.13 Median:49068.63 stddev:70039.70 (142.7%) stddev-sans-first:70210.65 19:19:35 INFO - PROCESS | 1135 | Values: 342.3 357.6 359.8 368.9 379.6 16510.1 17181.5 17326.7 17915.5 18023.9 14618.0 14798.5 14857.3 14918.6 14937.7 5019.3 5214.5 5225.3 5247.3 5253.1 3739.1 5044.9 5665.3 5931.4 5953.6 5966.6 5973.3 5989.3 5993.9 6024.8 6009.3 6033.1 6086.6 6088.8 6096.5 5130.2 5260.8 5279.8 5285.1 5285.9 20618.4 20824.9 20895.2 21505.4 21633.1 1893.8 2147.9 2171.3 2431.7 2468.0 13570.3 13577.3 13829.4 14085.8 14167.6 1698.5 1698.8 1772.2 1822.8 1835.7 68816.7 69877.7 70497.3 71647.6 71836.6 9298.0 9460.2 9597.5 9646.9 9884.9 13176.7 13228.5 13235.2 13240.7 13282.4 7170.8 7255.2 7329.7 7381.4 7423.4 7076.0 7132.9 7245.2 7317.2 7339.3 5744.8 5871.6 5882.4 5889.8 6205.4 1529.3 1637.1 1733.3 1766.2 1821.4 782.5 807.5 817.9 878.3 946.6 17966.2 18030.9 18646.8 18887.3 19069.6 895.5 908.0 930.4 941.6 946.1 10024.9 10682.4 10773.3 10828.0 10912.8 411491.0 419274.0 431135.0 432035.0 433486.0 74173.0 75958.6 79613.0 80383.6 80494.0 903.5 915.5 936.6 940.6 946.6 15939.3 16558.3 16670.9 16809.2 17033.3 35146.4 35775.6 36553.5 36674.4 37092.3 47369.0 47989.5 50147.7 50538.2 51227.2 7279.6 7316.5 7393.7 7443.1 7647.8 11558.5 11628.8 11757.8 12145.0 12211.1 10093.9 10279.4 10420.9 10492.6 10508.7 5069.6 9912.4 10177.1 10486.2 10612.6 9956.9 10030.8 10188.3 10430.4 10910.7 7181.7 7326.4 7400.8 7486.4 7682.5 9642.9 9736.0 9841.4 9945.4 10339.2 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#3] mootools.html Cycles:180 Average:4637.54 Median:4796.13 stddev:2531.35 (52.8%) stddev-sans-first:2526.46 19:19:35 INFO - PROCESS | 1135 | Values: 1359.7 1383.3 1444.2 1606.2 1642.0 6095.3 6654.9 6728.6 7206.1 7220.4 6831.3 7034.2 7107.6 7120.7 7131.3 2083.3 2111.1 2119.5 2120.4 2130.7 2068.7 2083.5 2095.6 2095.7 2108.4 2043.6 2051.1 2052.6 2053.0 2127.6 2099.4 2105.4 2105.5 2106.8 2117.0 2058.5 2059.1 2095.4 2102.1 2108.1 7188.4 7238.6 7240.7 7242.2 7242.6 3983.4 4171.3 4179.4 4190.1 4207.9 2682.2 2758.1 2790.0 2797.9 2798.2 865.2 894.8 925.3 933.3 950.7 9216.6 9285.7 9316.4 9404.5 9420.1 3793.0 3830.1 3944.1 3967.3 4002.6 8150.6 8154.6 8162.6 8167.3 8191.8 4178.5 4186.9 4190.7 4200.6 4215.3 3452.9 3808.0 3847.8 3849.2 3908.6 3377.7 3407.1 3545.2 3552.5 3567.7 1124.9 1142.2 1146.4 1155.8 1173.3 645.6 774.2 791.4 791.7 810.4 4555.5 4636.2 4643.9 4673.9 4724.9 392.5 393.6 398.1 402.6 406.9 3151.8 3153.0 3164.3 3164.8 3228.2 7955.6 8296.1 8371.8 8400.7 8477.0 8543.1 8543.5 8571.3 8581.8 8601.7 6635.7 6758.8 6764.6 6786.4 6813.3 4781.6 4810.6 4839.8 4898.3 4964.7 7815.0 7843.6 7879.7 7926.2 7990.7 7947.8 8002.7 8020.5 8181.7 8190.5 5415.0 6199.8 6225.6 6272.1 6421.0 6515.1 6643.2 6662.3 6662.9 6744.5 5775.7 6050.4 6076.5 6146.3 6146.6 5878.4 5979.3 6045.1 6082.1 6100.2 5594.3 5626.9 5634.8 5649.9 5663.7 4019.4 4072.5 4119.9 4164.2 4197.2 4112.1 4114.0 4136.4 4139.8 4183.8 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#4] prototype.html Cycles:180 Average:4328.96 Median:4982.78 stddev:1280.29 (25.7%) stddev-sans-first:1247.33 19:19:35 INFO - PROCESS | 1135 | Values: 281.9 287.5 289.5 292.0 292.9 4978.2 5027.2 5027.6 5041.6 5058.6 4890.1 4902.8 4915.7 4929.0 4987.3 3689.2 3738.4 3869.2 3882.9 3896.8 3894.9 3904.9 3906.3 3930.0 3933.6 3877.6 3887.3 3894.5 3896.4 3901.7 3737.4 3861.5 3875.3 3878.6 3884.9 3412.6 3418.0 3422.3 3428.3 3429.0 4830.3 4830.4 4839.5 4854.7 4862.3 4308.0 4437.7 4444.8 4445.8 4463.3 5136.4 5177.3 5182.8 5186.0 5196.9 3703.6 3708.8 3708.8 3720.0 3726.0 5462.6 5464.6 5467.8 5469.4 5477.7 3511.7 3698.4 3707.3 3718.9 3724.4 3757.7 3778.8 3779.4 3786.8 3795.8 4319.0 4346.0 4356.0 4359.4 4360.6 5124.6 5130.4 5225.9 5272.3 5279.5 1289.1 1302.4 1305.5 1306.3 1309.5 778.0 800.6 814.3 814.4 820.4 4410.7 4434.7 4623.3 4643.6 4680.3 5404.2 5423.6 5433.3 5440.7 5444.3 4567.5 4582.6 4633.9 4637.2 4648.2 2760.4 2847.0 2883.1 2883.4 2886.7 5072.9 5090.1 5094.4 5098.3 5104.3 5262.6 5540.9 5544.6 5550.0 5564.6 5052.2 5059.9 5065.9 5086.8 5096.8 5364.5 5400.2 5414.6 5447.2 5465.2 5010.3 5240.3 5242.7 5306.8 5315.9 5068.3 5070.0 5081.2 5081.6 5110.8 3690.5 3691.3 3699.2 3702.0 3707.4 5215.0 5344.5 5423.2 5434.5 5443.0 5231.6 5255.4 5259.5 5260.6 5273.4 5251.3 5271.5 5280.8 5289.5 5291.6 4908.3 5164.4 5183.2 5204.1 5204.7 5042.1 5171.5 5293.9 5299.6 5301.4 5166.7 5177.6 5189.6 5192.1 5192.4 19:19:35 INFO - PROCESS | 1135 | 19:19:35 INFO - PROCESS | 1135 | [#5] yui.html Cycles:180 Average:16012.84 Median:512.54 stddev:22207.46 (4332.8%) stddev-sans-first:22239.68 19:19:35 INFO - PROCESS | 1135 | Values: 621.0 621.2 697.6 733.7 748.6 12406.0 12831.6 13075.0 13625.4 13631.7 13387.6 13639.4 13665.6 13726.5 13730.9 626.2 753.9 773.0 773.9 774.3 757.5 764.7 764.9 785.1 785.5 805.7 807.9 810.7 811.7 813.4 794.2 801.1 803.2 803.8 806.3 584.2 584.3 585.4 590.5 594.7 12386.9 12399.0 12533.7 12540.1 12546.2 13139.8 13293.1 13494.4 13498.7 13781.0 9596.2 9630.5 9687.7 9696.7 9905.8 3206.5 3252.2 3258.4 3280.1 3283.9 62976.0 63797.0 64558.0 66199.0 66342.3 9963.9 10221.5 10267.8 10286.0 10414.6 19998.9 20010.2 20018.5 20036.9 20073.0 6577.9 6589.9 6624.0 6626.8 6863.2 3543.6 3744.8 3771.9 3802.8 3923.0 2756.1 2806.3 2826.4 2842.3 2844.7 468.8 479.2 485.2 488.2 495.2 494.3 587.4 587.9 590.2 593.9 7328.1 7800.4 7843.8 7910.3 8027.6 509.2 515.8 534.5 580.7 581.3 3479.3 3539.4 3594.3 3784.6 3819.4 50232.0 77453.2 79853.6 80846.2 92250.5 80319.2 82543.0 82800.6 82816.0 84054.6 43644.6 58009.0 71121.6 71614.0 73657.0 7682.8 7691.7 7929.2 7999.6 8091.1 43495.6 44250.6 45290.8 45298.3 46537.8 35775.8 36155.0 38252.0 38452.4 39790.8 10905.8 11263.8 11426.9 11591.1 11786.4 11352.1 11441.0 11469.7 11691.9 12168.6 10297.7 10498.3 10620.4 10636.7 10743.4 10352.3 10567.7 10671.8 11076.6 11112.9 9864.6 9937.3 10004.4 10523.7 11222.6 7892.1 8167.3 8881.8 9627.5 9786.9 8618.3 8627.7 8869.0 9080.9 9087.5 19:19:35 INFO - PROCESS | 1135 | -------- Summary: end -------- 19:19:35 INFO - PROCESS | 1135 | 19:19:36 INFO - TEST-INFO | 1135: exit 0 19:19:36 INFO - TEST-OK | dromaeo_css | took 1118009ms 19:19:36 INFO - TEST-START | kraken 19:19:36 INFO - operating with platform_type : linux_ 19:19:36 INFO - Initialising browser for kraken test... 19:19:36 INFO - TEST-INFO | started process 1455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGld05A/profile http://localhost:41080/getInfo.html) 19:19:41 INFO - PROCESS | 1455 | __metrics Screen width/height:1600/1200 19:19:41 INFO - PROCESS | 1455 | colorDepth:24 19:19:41 INFO - PROCESS | 1455 | Browser inner width/height: 1024/697 19:19:41 INFO - PROCESS | 1455 | __metrics 19:19:42 ERROR - PROCESS | 1455 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:19:43 INFO - TEST-INFO | 1455: exit 0 19:19:43 INFO - Browser initialized. 19:19:43 INFO - Running cycle 1/1 for kraken test... 19:19:43 INFO - TEST-INFO | started process 1576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGld05A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:55 INFO - PROCESS | 1576 | RSS: Main: 164098048 19:19:55 INFO - PROCESS | 1576 | 19:19:57 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41080/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:58 INFO - PROCESS | 1576 | RSS: Main: 170094592 19:19:58 INFO - PROCESS | 1576 | 19:20:01 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41080/tests/kraken/driver.html?testName=audio-dft) 19:20:02 INFO - PROCESS | 1576 | RSS: Main: 168620032 19:20:02 INFO - PROCESS | 1576 | 19:20:05 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41080/tests/kraken/driver.html?testName=audio-fft) 19:20:05 INFO - PROCESS | 1576 | RSS: Main: 164577280 19:20:05 INFO - PROCESS | 1576 | 19:20:08 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41080/tests/kraken/driver.html?testName=audio-oscillator) 19:20:08 INFO - PROCESS | 1576 | RSS: Main: 165670912 19:20:08 INFO - PROCESS | 1576 | 19:20:10 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:11 INFO - PROCESS | 1576 | RSS: Main: 167104512 19:20:11 INFO - PROCESS | 1576 | 19:20:14 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41080/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:15 INFO - PROCESS | 1576 | RSS: Main: 166342656 19:20:15 INFO - PROCESS | 1576 | 19:20:18 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41080/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:19 INFO - PROCESS | 1576 | RSS: Main: 163524608 19:20:19 INFO - PROCESS | 1576 | 19:20:22 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41080/tests/kraken/driver.html?testName=json-parse-financial) 19:20:23 INFO - PROCESS | 1576 | RSS: Main: 165109760 19:20:23 INFO - PROCESS | 1576 | 19:20:24 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:25 INFO - PROCESS | 1576 | RSS: Main: 166215680 19:20:25 INFO - PROCESS | 1576 | 19:20:27 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:28 INFO - PROCESS | 1576 | RSS: Main: 165838848 19:20:28 INFO - PROCESS | 1576 | 19:20:30 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:31 INFO - PROCESS | 1576 | RSS: Main: 166232064 19:20:31 INFO - PROCESS | 1576 | 19:20:33 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:34 INFO - PROCESS | 1576 | RSS: Main: 166973440 19:20:34 INFO - PROCESS | 1576 | 19:20:37 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:38 INFO - PROCESS | 1576 | RSS: Main: 166641664 19:20:38 INFO - PROCESS | 1576 | 19:20:39 INFO - PROCESS | 1576 | Cycle 1(1): loaded http://localhost:41080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41080/tests/kraken/driver.html?testName=ai-astar) 19:20:40 INFO - PROCESS | 1576 | RSS: Main: 167268352 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | __start_tp_report 19:20:40 INFO - PROCESS | 1576 | _x_x_mozilla_page_load 19:20:40 INFO - PROCESS | 1576 | _x_x_mozilla_page_load_details 19:20:40 INFO - PROCESS | 1576 | |i|pagename|runs| 19:20:40 INFO - PROCESS | 1576 | |0;ai-astar;110;117;110;118;120;117;118;117;116;116 19:20:40 INFO - PROCESS | 1576 | |1;audio-beat-detection;152;125;146;191;130;160;153;129;192;131 19:20:40 INFO - PROCESS | 1576 | |2;audio-dft;165;164;166;176;165;164;167;162;162;167 19:20:40 INFO - PROCESS | 1576 | |3;audio-fft;78;79;76;170;76;77;77;77;147;80 19:20:40 INFO - PROCESS | 1576 | |4;audio-oscillator;87;86;152;88;86;87;135;88;87;149 19:20:40 INFO - PROCESS | 1576 | |5;imaging-gaussian-blur;120;119;118;117;118;118;119;118;118;119 19:20:40 INFO - PROCESS | 1576 | |6;imaging-darkroom;151;149;148;149;149;149;149;148;148;147 19:20:40 INFO - PROCESS | 1576 | |7;imaging-desaturate;96;97;96;95;96;97;95;97;101;98 19:20:40 INFO - PROCESS | 1576 | |8;json-parse-financial;70;65;66;66;65;65;67;66;72;65 19:20:40 INFO - PROCESS | 1576 | |9;json-stringify-tinderbox;65;66;64;65;66;66;66;65;67;66 19:20:40 INFO - PROCESS | 1576 | |10;stanford-crypto-aes;80;81;83;93;81;84;81;80;85;93 19:20:40 INFO - PROCESS | 1576 | |11;stanford-crypto-ccm;132;130;135;142;133;132;141;134;174;136 19:20:40 INFO - PROCESS | 1576 | |12;stanford-crypto-pbkdf2;174;172;165;166;166;166;167;167;169;167 19:20:40 INFO - PROCESS | 1576 | |13;stanford-crypto-sha256-iterative;68;69;68;69;69;72;67;68;69;66 19:20:40 INFO - PROCESS | 1576 | __end_tp_report 19:20:40 INFO - PROCESS | 1576 | __start_cc_report 19:20:40 INFO - PROCESS | 1576 | _x_x_mozilla_cycle_collect,966 19:20:40 INFO - PROCESS | 1576 | __end_cc_report 19:20:40 INFO - PROCESS | 1576 | __startTimestamp1470277240021__endTimestamp 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | ------- Summary: start ------- 19:20:40 INFO - PROCESS | 1576 | Number of tests: 14 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:3.31 (2.8%) stddev-sans-first:2.74 19:20:40 INFO - PROCESS | 1576 | Values: 110.0 117.0 110.0 118.0 120.0 117.0 118.0 117.0 116.0 116.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:152.50 stddev:24.48 (16.1%) stddev-sans-first:25.96 19:20:40 INFO - PROCESS | 1576 | Values: 152.0 125.0 146.0 191.0 130.0 160.0 153.0 129.0 192.0 131.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.99 (2.4%) stddev-sans-first:4.23 19:20:40 INFO - PROCESS | 1576 | Values: 165.0 164.0 166.0 176.0 165.0 164.0 167.0 162.0 162.0 167.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#3] audio-fft Cycles:10 Average:93.70 Median:77.00 stddev:34.60 (44.9%) stddev-sans-first:36.23 19:20:40 INFO - PROCESS | 1576 | Values: 78.0 79.0 76.0 170.0 76.0 77.0 77.0 77.0 147.0 80.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:87.00 stddev:28.51 (32.8%) stddev-sans-first:29.53 19:20:40 INFO - PROCESS | 1576 | Values: 87.0 86.0 152.0 88.0 86.0 87.0 135.0 88.0 87.0 149.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.84 (0.7%) stddev-sans-first:0.67 19:20:40 INFO - PROCESS | 1576 | Values: 120.0 119.0 118.0 117.0 118.0 118.0 119.0 118.0 118.0 119.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:0.73 19:20:40 INFO - PROCESS | 1576 | Values: 151.0 149.0 148.0 149.0 149.0 149.0 149.0 148.0 148.0 147.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:1.75 (1.8%) stddev-sans-first:1.83 19:20:40 INFO - PROCESS | 1576 | Values: 96.0 97.0 96.0 95.0 96.0 97.0 95.0 97.0 101.0 98.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.00 stddev:2.41 (3.6%) stddev-sans-first:2.24 19:20:40 INFO - PROCESS | 1576 | Values: 70.0 65.0 66.0 66.0 65.0 65.0 67.0 66.0 72.0 65.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 19:20:40 INFO - PROCESS | 1576 | Values: 65.0 66.0 64.0 65.0 66.0 66.0 66.0 65.0 67.0 66.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:4.98 (6.0%) stddev-sans-first:5.05 19:20:40 INFO - PROCESS | 1576 | Values: 80.0 81.0 83.0 93.0 81.0 84.0 81.0 80.0 85.0 93.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:135.50 stddev:12.92 (9.5%) stddev-sans-first:13.46 19:20:40 INFO - PROCESS | 1576 | Values: 132.0 130.0 135.0 142.0 133.0 132.0 141.0 134.0 174.0 136.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.00 stddev:2.92 (1.8%) stddev-sans-first:2.11 19:20:40 INFO - PROCESS | 1576 | Values: 174.0 172.0 165.0 166.0 166.0 166.0 167.0 167.0 169.0 167.0 19:20:40 INFO - PROCESS | 1576 | 19:20:40 INFO - PROCESS | 1576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 19:20:40 INFO - PROCESS | 1576 | Values: 68.0 69.0 68.0 69.0 69.0 72.0 67.0 68.0 69.0 66.0 19:20:40 INFO - PROCESS | 1576 | -------- Summary: end -------- 19:20:40 INFO - PROCESS | 1576 | 19:20:41 INFO - TEST-INFO | 1576: exit 0 19:20:41 INFO - TEST-OK | kraken | took 64589ms 19:20:41 INFO - SUITE-END | took 1182s 19:20:41 INFO - Completed test suite (00:19:43) 19:20:41 INFO - javascript benchmark 19:20:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6347.165024430659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.61812537182, 2655.601659751037, 2667.9199624011276, 2675.3579141006167, 2684.6778386593605, 4732.716037037781, 4791.472937976824, 4855.198892182794, 4870.780814863331, 4919.827806026789, 4646.51211622779, 4696.530346965302, 4708.458527269357, 4855.150348688983, 4926.802927882889, 4298.957010429903, 4346.717463364887, 4356.1723272578265, 4397.230484665187, 4423.447069116361, 4409.338599210112, 4415.293553031515, 4418.072204836972, 4455.131249406367, 4491.505934347219, 4351.477822661269, 4396.0, 4408.118376324748, 4416.315471101984, 4496.595306422405, 4415.381846541487, 4434.35701823237, 4448.955510444886, 4467.553244675539, 4473.46318441789, 4429.6899217054815, 4438.400815889878, 4441.489228738672, 4454.886278430393, 4471.28459446487, 4768.213244814601, 4820.855374338776, 4839.225723884161, 4865.82969596066, 4936.506349365035, 5233.241180028875, 5253.658512196695, 5273.1035723927025, 5275.657082289677, 5290.629655924087, 5292.364916210041, 5293.04725149473, 5315.840524784263, 5334.0665383557725, 5351.197320401932, 4715.7877895494785, 4831.0820944020525, 4843.370361852936, 4868.756562171877, 4883.853484395474, 5284.260203571503, 5370.409254981949, 5380.031594312983, 5452.345718513804, 5462.863428414322, 5226.137687281632, 5226.477352264819, 5229.08491014071, 5237.816676416307, 5241.606879484054, 4967.801287948441, 5142.408623008327, 5154.793808247703, 5180.948190518122, 5232.189010703347, 5131.717755523482, 5168.483151684802, 5168.612354073384, 5213.087709650796, 5226.268322434862, 5173.042987047408, 5209.322788037531, 5212.530872221519, 5212.55693266069, 5247.9737601311745, 4212.3681447782465, 4365.672574556921, 4435.889102772457, 4438.778061096997, 4443.800028998703, 3820.8662696806036, 3827.5981021992848, 3840.4047372657283, 3875.147467557133, 3884.786336751449, 4517.593416592523, 4542.31865220213, 4569.337446070368, 4579.496255411902, 4611.1930412177735, 5081.2378143278065, 5193.37679478465, 5209.895802083937, 5224.791008359699, 5303.098473259555, 4498.1003799239625, 4508.098380323949, 4517.81928722854, 4532.9773351133035, 4558.635309175258, 4651.3720647712125, 4691.390119284471, 4696.131215725033, 4700.835470758507, 4704.694194877322, 4701.412323459636, 4821.180399332052, 4883.682560633548, 4887.193613053806, 4991.425986011655, 5238.68567885928, 5256.868578285574, 5278.6832790031185, 5284.920726189187, 5290.312259406252, 4924.556789888928, 4931.901361972668, 4939.901201975868, 4951.0, 5010.9248361273885, 4937.382827146606, 5045.495450455072, 5076.466970968143, 5087.135187018142, 5130.615203859651, 5179.30079439286, 5187.144121219956, 5192.273081768631, 5228.346456692913, 5238.371395432572, 4974.12952733263, 5008.148614735576, 5034.766482211881, 5060.468650791614, 5065.0, 4902.362692850049, 5067.163917953497, 5112.923306150336, 5127.256547800623, 5176.922346164735, 5058.747062646779, 5062.316587260672, 5069.264956581349, 5073.644844860824, 5125.615578831528, 5197.740112994411, 5203.635745497931, 5210.0, 5210.8957820844125, 5218.66078704883, 4773.451053128934, 5013.674111182907, 5050.646454748279, 5064.063148317573, 5144.6398752087], "value": 4774.946826012054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7764077907667, 539.8434454008335, 548.5063442901388, 554.6976897590814, 569.390751895472, 35533.64466355336, 39982.0, 40043.19913601726, 40104.59895401045, 40261.0, 39227.21545569094, 39736.0, 39774.40338394919, 39893.401598975965, 39913.40129898054, 7692.576908270057, 7769.300762931335, 7828.334591559725, 7838.529688218697, 7850.607469626524, 7765.8058548536455, 7782.49413788102, 7827.882581761278, 7840.372770178401, 7841.725539606115, 7796.1814009529035, 7824.256695613907, 7827.88258176125, 7861.135275119732, 7901.881471777928, 7827.765167044998, 7846.254605812439, 7852.21477852216, 7872.370210383156, 7882.448228623999, 7534.698612055511, 7602.581857997808, 7607.923920760777, 7626.313631773111, 7630.351420129296, 37573.62426375729, 37860.81069594635, 37894.81052594747, 37933.81033094844, 38000.42999354984, 2832.22113918674, 3020.4714175019285, 3134.81191128533, 3253.9186817762557, 3395.4906763985355, 29086.127416177547, 29122.271943201376, 29155.0, 29599.260018499495, 30705.846470767727, 3034.7117023882697, 3043.6804135565667, 3127.796693214934, 3141.780075394723, 3196.2968147007623, 250320.0, 250800.0, 251970.0, 253054.0, 253765.0, 51487.48512514902, 52283.73858130685, 52460.0, 52934.73532632389, 53004.73497632487, 32936.0, 33783.493247601305, 33840.984770456926, 35875.282494349965, 35989.8200509001, 15935.840641593435, 16052.197390130446, 16119.355225791072, 16186.271617777229, 16201.108939008467, 12073.154879158375, 12112.757744845054, 12191.45138468771, 12203.69490762738, 12207.694807629703, 18240.45278641643, 18281.17734701915, 18322.267109315744, 18466.169022394024, 18539.81460185408, 6383.3396531422795, 6646.567973081735, 6676.298988606127, 6769.729210831511, 6832.795016149524, 813.4346629092723, 835.8620827563384, 905.6060613633091, 911.4485736129678, 985.1527686189871, 26496.33759155998, 28015.579766303523, 28102.43795124127, 28483.715162848108, 28808.567871481944, 951.4481600671733, 988.48104745008, 1004.7036124343336, 1061.1722856172198, 1106.8893110688866, 15053.397864085315, 15058.0, 15074.321655525528, 15084.77763810379, 15091.471798487, 395864.0, 401750.0, 401788.0, 403115.0, 403283.0, 50668.49331506711, 50721.0, 50892.74553627208, 51162.488375115776, 51189.0, 1159.646307876106, 1185.525789684116, 1213.5813144465146, 1214.8724383939737, 1218.945147468366, 26147.0, 27823.721762782112, 29835.254118647208, 32091.35817283688, 33024.834875825465, 49274.0, 50000.74999624979, 50135.24797128119, 50146.49853501418, 50182.749086254335, 369562.0, 372348.0, 372885.0, 373144.0, 374163.0, 37815.05462363353, 39297.60702392939, 39693.0, 39826.0, 39906.004699764315, 42437.78781106198, 43211.783941080095, 43334.34998475089, 43485.0, 44001.67994960157, 36082.4587631191, 36291.0, 36456.635433646385, 36904.81547592245, 37260.81369593243, 36701.63298366982, 37074.44388334231, 37291.62708372882, 37358.0, 38370.42444363393, 35749.92750217498, 36608.0, 36700.81649591735, 36764.080897977765, 37083.44374834433, 32210.516842246918, 34104.31791364109, 34349.65650343464, 34582.82708586441, 34944.82527587346, 26038.86980565085, 26079.739202607732, 26226.868865656314, 26261.0, 26673.33316667099], "value": 17853.328375834084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.318785616623, 357.5994885727985, 359.8254846399496, 368.9243705040467, 379.56539761972545, 16510.091944943037, 17181.48455546334, 17326.65346693067, 17915.462536123905, 18023.90988045058, 14618.0, 14798.482053128142, 14857.257137143153, 14918.62703432412, 14937.701245975073, 5019.297298378239, 5214.504622060898, 5225.346831646044, 5247.317848679666, 5253.0544501989625, 3739.1026153723183, 5044.949550504484, 5665.263515742948, 5931.406859314077, 5953.553483488734, 5966.552508561854, 5973.313068997056, 5989.281286245635, 5993.910091348634, 6024.795040991798, 6009.338972712998, 6033.09503574463, 6086.573939824214, 6088.756449742005, 6096.481799047064, 5130.204818253177, 5260.815871444519, 5279.815206467755, 5285.07511185541, 5285.947140528584, 20618.381448556418, 20824.895875520677, 20895.164193432243, 21505.354839354844, 21633.134674612997, 1893.7916829148783, 2147.881866497342, 2171.250918433138, 2431.671724317212, 2467.9634553487576, 13570.253636050013, 13577.321133943264, 13829.446822127104, 14085.788713169311, 14167.645808854759, 1698.5329034515485, 1698.8131305556378, 1772.2113659421564, 1822.7539282197, 1835.7246413038151, 68816.6559167206, 69877.65061174662, 70497.2950270496, 71647.64176179138, 71836.64081679558, 9297.95351023254, 9460.24318054554, 9597.472139032281, 9646.90353096474, 9884.901150988542, 13176.73646527064, 13228.537001205104, 13235.205887646773, 13240.668983275302, 13282.402291896695, 7170.8207294817, 7255.165655949633, 7329.706811727471, 7381.409487241008, 7423.369013633794, 7076.044733960953, 7132.893006604905, 7245.239249878792, 7317.231690672403, 7339.266073392725, 5744.827655170351, 5871.618344807659, 5882.382349853204, 5889.823305300848, 6205.379462053849, 1529.2506671730994, 1637.10777626194, 1733.34133029448, 1766.1522469214592, 1821.3989383503413, 782.5383024015858, 807.5316316536512, 817.9386546009073, 878.3193025405362, 946.5929650250321, 17966.191521381308, 18030.90984545095, 18646.813531864507, 18887.338943136925, 19069.618607628046, 895.4761464543316, 907.9909200908038, 930.3952430919821, 941.5951141009294, 946.0917519181526, 10024.899751002542, 10682.359058456517, 10773.299735517166, 10828.0, 10912.836307455394, 411491.0, 419274.0, 431135.0, 432035.0, 433486.0, 74173.0, 75958.62020689862, 79613.0, 80383.59808200922, 80494.0, 903.4534106865383, 915.54680433186, 936.5925822267335, 940.6331530703031, 946.6213514594217, 15939.282732277306, 16558.254878530253, 16670.916645416695, 16809.243584038504, 17033.31866725367, 35146.36402269891, 35775.64224357723, 36553.45169822402, 36674.44988325231, 37092.25815483729, 47369.0, 47989.5201047985, 50147.74926125346, 50538.2419263704, 51227.2315915269, 7279.563226206445, 7316.451266154953, 7393.741219057307, 7443.144038435433, 7647.847043059219, 11558.479868405773, 11628.767424651629, 11757.764844702888, 12145.0, 12211.084168687561, 10093.949530252301, 10279.434631095062, 10420.947895260779, 10492.580296788348, 10508.686414198226, 5069.645124841226, 9912.405255684682, 10177.134943529883, 10486.16110711126, 10612.628558000433, 9956.850647240442, 10030.849537256801, 10188.337758046, 10430.426326552113, 10910.672679819618, 7181.712731490682, 7326.413886889142, 7400.814979625337, 7486.363659088821, 7682.539047657158, 9642.855357169508, 9736.004119155414, 9841.360311579725, 9945.403275803475, 10339.172866170838], "value": 8457.464730497077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.7076628524865, 1383.3152589468216, 1444.2201211345873, 1606.1647943069597, 1641.998380987598, 6095.299040610331, 6654.86690266195, 6728.59628422295, 7206.099237595301, 7220.350168484835, 6831.316868313166, 7034.1910680271785, 7107.644617769117, 7120.715171393151, 7131.322524360177, 2083.260442542898, 2111.144986280559, 2119.5337025854365, 2120.4486833423343, 2130.6910497977783, 2068.720722702431, 2083.5312054787705, 2095.559932414195, 2095.706601075851, 2108.3569511299047, 2043.5708501214688, 2051.107768120872, 2052.5586998795256, 2053.035073515445, 2127.5532138250987, 2099.391176558796, 2105.3683894831565, 2105.49468127649, 2106.799854013866, 2117.04732870209, 2058.5162486815584, 2059.06312627754, 2095.371388583419, 2102.096098677568, 2108.135664377613, 7188.388986936065, 7238.638068096627, 7240.674169662378, 7242.23956484572, 7242.6378681065735, 3983.382575700771, 4171.290880550314, 4179.373094035888, 4190.141021090669, 4207.852725154605, 2682.158862617832, 2758.1449750577385, 2789.9581506277423, 2797.9440411191663, 2798.2164993801766, 865.2472349056361, 894.7941973346167, 925.296774451415, 933.272047802715, 950.7337945375236, 9216.631334746602, 9285.721428357092, 9316.44101353921, 9404.529773511296, 9420.105090016506, 3792.9620703792607, 3830.0999265172663, 3944.092858642471, 3967.3255546557157, 4002.579729128458, 8150.633221504928, 8154.592270386457, 8162.632681529345, 8167.305779008732, 8191.754247372588, 4178.498580170338, 4186.869545222773, 4190.685698572558, 4200.579942005775, 4215.325547912381, 3452.913677158041, 3808.0, 3847.846086156578, 3849.1531862990096, 3908.5700572936953, 3377.7297816174646, 3407.1311815486893, 3545.2023294758474, 3552.4671299304796, 3567.661072198137, 1124.9268797528134, 1142.2289954280827, 1146.3523109443138, 1155.7919574476507, 1173.3018853781987, 645.6319897658384, 774.1600363605438, 791.4143533785073, 791.7070683847013, 810.440795850861, 4555.453345598549, 4636.211843986531, 4643.907121857544, 4673.883152921204, 4724.905501889943, 392.4956430986169, 393.6358868047045, 398.1280994621769, 402.61147992187097, 406.89013966229544, 3151.8108913465267, 3152.9684703153134, 3164.256399746058, 3164.810111393324, 3228.2413632796274, 7955.641996110189, 8296.128906464855, 8371.832563348698, 8400.747977560683, 8477.0, 8543.145685431407, 8543.530105844115, 8571.314294856396, 8581.828363432696, 8601.698940537051, 6635.734570617218, 6758.797236082925, 6764.5603035802515, 6786.423154031864, 6813.284605116491, 4781.641376896816, 4810.615150787999, 4839.806407743792, 4898.314236007033, 4964.702117872939, 7814.960925195338, 7843.647035883513, 7879.724209652634, 7926.24700653437, 7990.720324788605, 7947.84104317922, 8002.679892804223, 8020.518768873886, 8181.713640022571, 8190.549519776469, 5415.0, 6199.783007594712, 6225.595336303126, 6272.121902933502, 6421.0, 6515.12045873801, 6643.169603799525, 6662.267150613526, 6662.900056499059, 6744.460443164633, 5775.653460792366, 6050.42520960508, 6076.483498902466, 6146.323904370605, 6146.631202127886, 5878.441548053099, 5979.252593425822, 6045.093236014633, 6082.148499210202, 6100.176476175837, 5594.328680558359, 5626.943730562805, 5634.830955071355, 5649.887002260014, 5663.66018038919, 4019.376996565537, 4072.450219220486, 4119.876403707894, 4164.208800327928, 4197.181549597921, 4112.090022236958, 4113.958860411477, 4136.400221967738, 4139.81370838319, 4183.811728472165], "value": 3730.9946921328083, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.93092692290384, 287.5126660310773, 289.4962764789266, 291.9810212336197, 292.94287613915293, 4978.228374601938, 5027.220780778981, 5027.622928280375, 5041.596672266219, 5058.570021548164, 4890.119778439879, 4902.828401005965, 4915.705057696532, 4928.950710492894, 4987.326710894028, 3689.2252626948375, 3738.4392341148773, 3869.2454971280613, 3882.864099756509, 3896.8246428910766, 3894.922101557967, 3904.882853514399, 3906.277338692337, 3930.0, 3933.5869733677982, 3877.5734669186368, 3887.300285948528, 3894.532656081274, 3896.376579747241, 3901.7073719471155, 3737.4206997915094, 3861.4593956846065, 3875.2636998970247, 3878.5733569307354, 3884.8633251711444, 3412.607550131742, 3417.96582034179, 3422.3326451342, 3428.3143371325837, 3428.9657103428895, 4830.275458681191, 4830.4203495580405, 4839.467658557556, 4854.68444551103, 4862.294967229767, 4307.978460107679, 4437.668699390202, 4444.777761111932, 4445.777711114463, 4463.303944501069, 5136.383633963948, 5177.301064356301, 5182.766775495112, 5185.974070129625, 5196.870078248036, 3703.6111208323277, 3708.7774733516076, 3708.796016219107, 3719.962800372016, 3725.9627403725885, 5462.644928079662, 5464.617476776627, 5467.824417750163, 5469.3983661797565, 5477.657973796446, 3511.701505372072, 3698.3712768829364, 3707.3141468828353, 3718.9442158367647, 3724.4227144792058, 3757.680597149273, 3778.8110594470168, 3779.3764028935466, 3786.8036538807423, 3795.7532760370486, 4318.978405107954, 4345.97827010863, 4356.0, 4359.38968544404, 4360.607545320936, 5124.564412024945, 5130.410002849645, 5225.869353266199, 5272.314599102092, 5279.498447647467, 1289.1427200911476, 1302.426932149851, 1305.5104335874048, 1306.301128896036, 1309.4631201207649, 777.992220077792, 800.5516910530006, 814.2940539569593, 814.3566582399956, 820.3560205238858, 4410.713303635318, 4434.711743736647, 4623.329617205486, 4643.605293550018, 4680.321353403738, 5404.189371594213, 5423.647462914898, 5433.320834895638, 5440.6735595864375, 5444.3194600674915, 4567.51242894208, 4582.587567118975, 4633.86098417048, 4637.234856248681, 4648.233041548175, 2760.3513174403997, 2846.985765071203, 2883.1062370665163, 2883.351245969682, 2886.6680331761695, 5072.873178170576, 5090.1240798948475, 5094.363204599425, 5098.337216161875, 5104.285400043997, 5262.55268302191, 5540.861478463071, 5544.611877168641, 5550.0, 5564.554835613141, 5052.242163675478, 5059.949400505948, 5065.949340506621, 5086.821961231339, 5096.796128154906, 5364.517193452608, 5400.216968539618, 5414.648047876875, 5447.1829225616475, 5465.234867118527, 5010.273510341053, 5240.318758561515, 5242.737863106753, 5306.832496850687, 5315.93681263741, 5068.26510156018, 5069.9746501267255, 5081.161608334583, 5081.568066714222, 5110.8466745997675, 3690.538682664667, 3691.3171063353366, 3699.186179040607, 3701.981490092532, 3707.369747142938, 5214.97392513035, 5344.518993290622, 5423.213634023124, 5434.483724046209, 5442.972785136049, 5231.55531779803, 5255.448177941261, 5259.47405259471, 5260.552853007384, 5273.419923808301, 5251.267081863052, 5271.525562699376, 5280.808464487195, 5289.4710528948335, 5291.629585928948, 4908.28829819667, 5164.431912489548, 5183.248428977702, 5204.0892843752945, 5204.661696989683, 5042.067217564762, 5171.482851714798, 5293.947060529499, 5299.648589609625, 5301.443348448512, 5166.741662916915, 5177.559907407913, 5189.6107791915, 5192.117340052276, 5192.350956130484], "value": 3909.4873240348347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.0342916764431, 621.2141640824357, 697.5849369625074, 733.6845156582667, 748.5957582905231, 12406.0, 12831.615051548446, 13075.0, 13625.386857591408, 13631.659208519779, 13387.59837204883, 13639.386227619756, 13665.590032299022, 13726.45094196231, 13730.931345343259, 626.2203556572074, 753.898223739795, 773.0182668011622, 773.9397026074258, 774.2915232562199, 757.4811254290801, 764.7246991083206, 764.9196834332398, 785.0892964161574, 785.505131766986, 805.673702150627, 807.8828569857396, 810.7081450677751, 811.736185739637, 813.4021494201756, 794.1542257495748, 801.1307731111722, 803.2008151888908, 803.7749430159565, 806.3388021822108, 584.220066211608, 584.2959234122915, 585.4116612804147, 590.5482306035886, 594.6937327276456, 12386.938065309705, 12399.0, 12533.686657833536, 12540.059495537871, 12546.1844980076, 13139.802902956464, 13293.138960545532, 13494.392752326168, 13498.662533436644, 13781.0, 9596.184324332371, 9630.518474076338, 9687.70936871895, 9696.660616878446, 9905.801883962353, 3206.5190221466964, 3252.2194673278477, 3258.397196518628, 3280.1471617379416, 3283.8522266497826, 62976.0, 63797.043044354374, 64558.0, 66199.00701489433, 66342.3365766341, 9963.850542241873, 10221.488925553693, 10267.794644107076, 10286.0, 10414.5834166634, 19998.90000549988, 20010.199592016448, 20018.499537511678, 20036.89981550083, 20073.0, 6577.901331480031, 6589.86820263592, 6624.0, 6626.801195964129, 6863.176418829772, 3543.5825917782868, 3744.7565908216425, 3771.9434208486896, 3802.7718336899875, 3923.0388554803685, 2756.0767143007315, 2806.270369703851, 2826.392325649995, 2842.303635609289, 2844.672862620825, 468.7867020505662, 479.2093046473347, 485.18004572272747, 488.23834817684525, 495.23238979581504, 494.3400560252032, 587.4008511318432, 587.9088741245029, 590.2091197794975, 593.8542528986371, 7328.120625524864, 7800.414968877357, 7843.762614055973, 7910.327622152066, 8027.598620068973, 509.23868816120137, 515.8452464260707, 534.516262782175, 580.6980370207468, 581.3169525807244, 3479.2519608283833, 3539.380608393521, 3594.3350480161253, 3784.6215378462484, 3819.350710379242, 50232.0, 77453.2254677446, 79853.60073199598, 80846.19153808504, 92250.53874730718, 80319.19680803234, 82543.0, 82800.58599707084, 82816.0, 84054.5797271022, 43644.56355436405, 58009.0, 71121.64439177874, 71614.0, 73656.99999999892, 7682.8079298018, 7691.692332306645, 7929.207079292025, 7999.560024198725, 8091.06952700447, 43495.565044349154, 44250.55749442593, 45290.773546132055, 45298.32052519281, 46537.767311163225, 35775.82112089423, 36155.0, 38252.0, 38452.42321365126, 39790.80104599459, 10905.764318314568, 11263.831042534204, 11426.94286528562, 11591.072714182677, 11786.351750653796, 11352.091832653534, 11441.0, 11469.713257168303, 11691.941540292244, 12168.600610929856, 10297.691069267934, 10498.3329275382, 10620.415877126523, 10636.734081648021, 10743.409112498888, 10352.327098738559, 10567.682969510926, 10671.786564268516, 11076.612318569134, 11112.944435277772, 9864.5560949756, 9937.304388692723, 10004.449755263238, 10523.736906577396, 11222.55109795599, 7892.131865494676, 8167.264946154874, 8881.822363552821, 9627.470489123165, 9786.85319720219, 8618.310535157298, 8627.654893804429, 8869.0, 9080.863787043332, 9087.454752714859], "value": 6216.600364899264, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 110.0, 118.0, 120.0, 117.0, 118.0, 117.0, 116.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 146.0, 191.0, 130.0, 160.0, 153.0, 129.0, 192.0, 131.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 176.0, 165.0, 164.0, 167.0, 162.0, 162.0, 167.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 76.0, 170.0, 76.0, 77.0, 77.0, 77.0, 147.0, 80.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 152.0, 88.0, 86.0, 87.0, 135.0, 88.0, 87.0, 149.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 147.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 97.0, 95.0, 97.0, 101.0, 98.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 72.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 83.0, 93.0, 81.0, 84.0, 81.0, 80.0, 85.0, 93.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 135.0, 142.0, 133.0, 132.0, 141.0, 134.0, 174.0, 136.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 165.0, 166.0, 166.0, 166.0, 167.0, 167.0, 169.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 72.0, 67.0, 68.0, 69.0, 66.0], "value": 68.5, "unit": "score"}]}]} 19:20:41 INFO - Return code: 0 19:20:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:41 ERROR - # TBPL SUCCESS # 19:20:41 INFO - Running post-action listener: _resource_record_post_action 19:20:41 INFO - [mozharness: 2016-08-04 02:20:41.846344Z] Finished run-tests step (success) 19:20:41 INFO - Running post-run listener: _resource_record_post_run 19:20:41 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547774464; Read time: 16; Write time: 615400 19:20:41 INFO - TinderboxPrint: CPU usage
13.4% 19:20:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:20:41 INFO - TinderboxPrint: I/O write bytes / time
547,774,464 / 615,400 19:20:41 INFO - TinderboxPrint: CPU idle
8,284.5 (86.6%) 19:20:41 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 19:20:41 INFO - TinderboxPrint: Swap in / out
0 / 0 19:20:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237084672; Read time: 0; Write time: 335280 19:20:41 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 295174144; Read time: 0; Write time: 276884 19:20:42 INFO - Running post-run listener: _upload_blobber_files 19:20:42 INFO - Blob upload gear active. 19:20:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:42 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 19:20:42 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'] 19:20:42 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 19:20:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:43 INFO - (blobuploader) - INFO - Done attempting. 19:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:47 INFO - (blobuploader) - INFO - Done attempting. 19:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:48 INFO - (blobuploader) - INFO - Done attempting. 19:20:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:48 INFO - Return code: 0 19:20:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eec47ee6a4f423c37d0efc110ab4af0839caad6aa627a38f4e74a77dc3e6519bf316a8421f9451a68a49248c361574db3e501b452030a374ef080640c9895461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/10ef5bf82dedac004b6555fc2bb1f13159f2d7ed09abc27dc321b096cfd062cb9db3bf00af1c37187fec8e7e9c5fa838bdb5bca761c7a24c3bbf70fb0afc29c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/113bfc64ecd403e7a94a8c6c9342a7fc326b4770c1b2615c0abd0a39419bab246d5e74ff6d587d4546b786e6339516e001c35e95f296b8e64201c63160ddc771"} 19:20:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:48 INFO - Contents: 19:20:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eec47ee6a4f423c37d0efc110ab4af0839caad6aa627a38f4e74a77dc3e6519bf316a8421f9451a68a49248c361574db3e501b452030a374ef080640c9895461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/10ef5bf82dedac004b6555fc2bb1f13159f2d7ed09abc27dc321b096cfd062cb9db3bf00af1c37187fec8e7e9c5fa838bdb5bca761c7a24c3bbf70fb0afc29c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/113bfc64ecd403e7a94a8c6c9342a7fc326b4770c1b2615c0abd0a39419bab246d5e74ff6d587d4546b786e6339516e001c35e95f296b8e64201c63160ddc771"} 19:20:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:48 INFO - Copying logs to upload dir... 19:20:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.061153 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-03 19:20:47.620273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 19:20:47.623806) ========= 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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eec47ee6a4f423c37d0efc110ab4af0839caad6aa627a38f4e74a77dc3e6519bf316a8421f9451a68a49248c361574db3e501b452030a374ef080640c9895461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/10ef5bf82dedac004b6555fc2bb1f13159f2d7ed09abc27dc321b096cfd062cb9db3bf00af1c37187fec8e7e9c5fa838bdb5bca761c7a24c3bbf70fb0afc29c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/113bfc64ecd403e7a94a8c6c9342a7fc326b4770c1b2615c0abd0a39419bab246d5e74ff6d587d4546b786e6339516e001c35e95f296b8e64201c63160ddc771"} build_url:https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/XhjJYExsSTSfiMCYYenS-Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eec47ee6a4f423c37d0efc110ab4af0839caad6aa627a38f4e74a77dc3e6519bf316a8421f9451a68a49248c361574db3e501b452030a374ef080640c9895461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/10ef5bf82dedac004b6555fc2bb1f13159f2d7ed09abc27dc321b096cfd062cb9db3bf00af1c37187fec8e7e9c5fa838bdb5bca761c7a24c3bbf70fb0afc29c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/113bfc64ecd403e7a94a8c6c9342a7fc326b4770c1b2615c0abd0a39419bab246d5e74ff6d587d4546b786e6339516e001c35e95f296b8e64201c63160ddc771"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 19:20:47.649715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:20:47.650071) ========= 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=52faae308a556c440401f8e5000001e8-1470276004.666041-99612504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 19:20:47.733475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 19:20:47.733829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 19:20:47.734167) ========= ========= Total master_lag: 0.15 =========